2025-02-05 08:14:25.452686 | Job console starting... 2025-02-05 08:14:25.485877 | Updating repositories 2025-02-05 08:14:25.532330 | Preparing job workspace 2025-02-05 08:14:27.997307 | Running Ansible setup... 2025-02-05 08:14:34.704646 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-05 08:14:36.650895 | 2025-02-05 08:14:36.651431 | PLAY [Base pre] 2025-02-05 08:14:36.725001 | 2025-02-05 08:14:36.725183 | TASK [Setup log path fact] 2025-02-05 08:14:36.773759 | ubuntu-noble | ok 2025-02-05 08:14:36.821930 | 2025-02-05 08:14:36.822106 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 08:14:36.926374 | ubuntu-noble | ok 2025-02-05 08:14:36.941239 | 2025-02-05 08:14:36.941774 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 08:14:37.043891 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:37.052218 | 2025-02-05 08:14:37.052405 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 08:14:37.201133 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:37.209776 | 2025-02-05 08:14:37.209907 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 08:14:37.281618 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:37.290146 | 2025-02-05 08:14:37.290282 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 08:14:37.390414 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:37.420307 | 2025-02-05 08:14:37.420512 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 08:14:37.462825 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:37.497859 | 2025-02-05 08:14:37.498042 | TASK [emit-job-header : Print job information] 2025-02-05 08:14:37.669760 | # Job Information 2025-02-05 08:14:37.669978 | Ansible Version: 2.15.3 2025-02-05 08:14:37.670013 | Job: ansible-collection-ensure-readme 2025-02-05 08:14:37.670042 | Pipeline: check 2025-02-05 08:14:37.670063 | Executor: 7d211f194f6a 2025-02-05 08:14:37.670082 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1750 2025-02-05 08:14:37.670100 | Event ID: 31d99820-e399-11ef-8d3f-b516d1cd041a 2025-02-05 08:14:37.683725 | 2025-02-05 08:14:37.683850 | LOOP [emit-job-header : Print node information] 2025-02-05 08:14:38.051610 | ubuntu-noble | ok: 2025-02-05 08:14:38.051891 | ubuntu-noble | # Node Information 2025-02-05 08:14:38.051930 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-05 08:14:38.051955 | ubuntu-noble | Hostname: ubuntu 2025-02-05 08:14:38.051977 | ubuntu-noble | Username: zuul 2025-02-05 08:14:38.051996 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-05 08:14:38.052015 | ubuntu-noble | Provider: regiocloud-a 2025-02-05 08:14:38.052034 | ubuntu-noble | Label: ubuntu-noble 2025-02-05 08:14:38.052053 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-05 08:14:38.052073 | ubuntu-noble | Interface IP: 81.163.193.250 2025-02-05 08:14:38.088854 | 2025-02-05 08:14:38.088999 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-05 08:14:38.912111 | ubuntu-noble -> localhost | changed 2025-02-05 08:14:38.923974 | 2025-02-05 08:14:38.924087 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-05 08:14:41.280893 | ubuntu-noble -> localhost | changed 2025-02-05 08:14:41.295037 | 2025-02-05 08:14:41.295150 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-05 08:14:41.867052 | ubuntu-noble -> localhost | ok 2025-02-05 08:14:41.874732 | 2025-02-05 08:14:41.874845 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-05 08:14:41.929537 | ubuntu-noble | ok 2025-02-05 08:14:41.981192 | ubuntu-noble | included: /var/lib/zuul/builds/fb1a1b595c5547c0ba5b8d321806e145/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-05 08:14:41.988761 | 2025-02-05 08:14:41.988860 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-05 08:14:43.011159 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-05 08:14:43.011368 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb1a1b595c5547c0ba5b8d321806e145/work/fb1a1b595c5547c0ba5b8d321806e145_id_rsa 2025-02-05 08:14:43.011407 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb1a1b595c5547c0ba5b8d321806e145/work/fb1a1b595c5547c0ba5b8d321806e145_id_rsa.pub 2025-02-05 08:14:43.011447 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-05 08:14:43.011473 | ubuntu-noble -> localhost | SHA256:uElkx4JnIqiuugHj5jjVnIBGSinFcoNBFijBSWQuHIA zuul-build-sshkey 2025-02-05 08:14:43.011495 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-05 08:14:43.011519 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-05 08:14:43.011541 | ubuntu-noble -> localhost | |%#= | 2025-02-05 08:14:43.011561 | ubuntu-noble -> localhost | |EB= . . | 2025-02-05 08:14:43.011580 | ubuntu-noble -> localhost | |O*..o * o | 2025-02-05 08:14:43.011600 | ubuntu-noble -> localhost | |=... * + | 2025-02-05 08:14:43.011619 | ubuntu-noble -> localhost | |= + .o S | 2025-02-05 08:14:43.011638 | ubuntu-noble -> localhost | |+.. +. o | 2025-02-05 08:14:43.011657 | ubuntu-noble -> localhost | |.= o | 2025-02-05 08:14:43.011676 | ubuntu-noble -> localhost | |*. | 2025-02-05 08:14:43.011696 | ubuntu-noble -> localhost | |*+ | 2025-02-05 08:14:43.011715 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-05 08:14:43.011761 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.431740 2025-02-05 08:14:43.020154 | 2025-02-05 08:14:43.020250 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-05 08:14:43.050134 | ubuntu-noble | ok 2025-02-05 08:14:43.060860 | ubuntu-noble | included: /var/lib/zuul/builds/fb1a1b595c5547c0ba5b8d321806e145/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-05 08:14:43.088274 | 2025-02-05 08:14:43.088372 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-05 08:14:43.112028 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:43.119179 | 2025-02-05 08:14:43.119283 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-05 08:14:43.873173 | ubuntu-noble | changed 2025-02-05 08:14:43.886941 | 2025-02-05 08:14:43.887048 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-05 08:14:44.272351 | ubuntu-noble | ok 2025-02-05 08:14:44.284825 | 2025-02-05 08:14:44.285142 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-05 08:14:45.032527 | ubuntu-noble | changed 2025-02-05 08:14:45.039554 | 2025-02-05 08:14:45.039658 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-05 08:14:45.784241 | ubuntu-noble | changed 2025-02-05 08:14:45.791185 | 2025-02-05 08:14:45.791275 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-05 08:14:45.835552 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:45.844752 | 2025-02-05 08:14:45.844852 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-05 08:14:46.696905 | ubuntu-noble -> localhost | changed 2025-02-05 08:14:46.714031 | 2025-02-05 08:14:46.714136 | TASK [add-build-sshkey : Add back temp key] 2025-02-05 08:14:47.056876 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/fb1a1b595c5547c0ba5b8d321806e145/work/fb1a1b595c5547c0ba5b8d321806e145_id_rsa (zuul-build-sshkey) 2025-02-05 08:14:47.057255 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008915 2025-02-05 08:14:47.070023 | 2025-02-05 08:14:47.070148 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-05 08:14:47.444094 | ubuntu-noble | ok 2025-02-05 08:14:47.457005 | 2025-02-05 08:14:47.457112 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-05 08:14:47.528112 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 08:14:47.546542 | 2025-02-05 08:14:47.546652 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-05 08:14:47.962591 | ubuntu-noble | ok 2025-02-05 08:14:47.980853 | 2025-02-05 08:14:47.980964 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-05 08:14:48.028119 | ubuntu-noble | ok 2025-02-05 08:14:48.034614 | 2025-02-05 08:14:48.034719 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-05 08:14:48.356323 | ubuntu-noble -> localhost | ok 2025-02-05 08:14:48.365543 | 2025-02-05 08:14:48.365683 | TASK [validate-host : Collect information about the host] 2025-02-05 08:14:49.534982 | ubuntu-noble | ok 2025-02-05 08:14:49.565970 | 2025-02-05 08:14:49.566087 | TASK [validate-host : Sanitize hostname] 2025-02-05 08:14:49.625950 | ubuntu-noble | ok 2025-02-05 08:14:49.631921 | 2025-02-05 08:14:49.632013 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-05 08:14:50.397564 | ubuntu-noble -> localhost | changed 2025-02-05 08:14:50.404176 | 2025-02-05 08:14:50.404278 | TASK [validate-host : Collect information about zuul worker] 2025-02-05 08:14:50.958043 | ubuntu-noble | ok 2025-02-05 08:14:50.968259 | 2025-02-05 08:14:50.968488 | TASK [validate-host : Write out all zuul information for each host] 2025-02-05 08:14:51.815936 | ubuntu-noble -> localhost | changed 2025-02-05 08:14:51.828982 | 2025-02-05 08:14:51.829115 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-05 08:14:52.105664 | ubuntu-noble | ok 2025-02-05 08:14:52.117905 | 2025-02-05 08:14:52.118047 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-05 08:14:53.475646 | ubuntu-noble | changed: 2025-02-05 08:14:53.475858 | ubuntu-noble | cd+++++++++ src/ 2025-02-05 08:14:53.475892 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-05 08:14:53.475917 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-05 08:14:53.475938 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-05 08:14:53.475958 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007752 2025-02-05 08:15:13.189739 | 2025-02-05 08:15:13.189868 | TASK [upload-logs : Upload logs to log server] 2025-02-05 08:15:13.776779 | localhost | Output suppressed because no_log was given 2025-02-05 08:15:13.781806 | 2025-02-05 08:15:13.781931 | LOOP [upload-logs : Compress console log and json output] 2025-02-05 08:15:13.851826 | localhost | skipping: Conditional result was False 2025-02-05 08:15:13.882344 | localhost | skipping: Conditional result was False 2025-02-05 08:15:13.900895 | 2025-02-05 08:15:13.901320 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-05 08:15:13.972132 | localhost | skipping: Conditional result was False 2025-02-05 08:15:13.973096 | 2025-02-05 08:15:13.996522 | localhost | skipping: Conditional result was False 2025-02-05 08:15:14.012794 | 2025-02-05 08:15:14.013163 | LOOP [upload-logs : Upload console log and json output]