2025-02-25 22:03:17.971564 | Job console starting... 2025-02-25 22:03:17.981864 | Updating repositories 2025-02-25 22:03:18.018389 | Preparing job workspace 2025-02-25 22:03:19.393783 | Running Ansible setup... 2025-02-25 22:03:24.946192 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 22:03:25.756126 | 2025-02-25 22:03:25.756465 | PLAY [Base pre] 2025-02-25 22:03:25.789047 | 2025-02-25 22:03:25.789200 | TASK [Setup log path fact] 2025-02-25 22:03:25.832050 | ubuntu-noble | ok 2025-02-25 22:03:25.859064 | 2025-02-25 22:03:25.859215 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 22:03:25.950847 | ubuntu-noble | ok 2025-02-25 22:03:25.964324 | 2025-02-25 22:03:25.964528 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 22:03:26.003031 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:26.016457 | 2025-02-25 22:03:26.016641 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 22:03:26.064513 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:26.076887 | 2025-02-25 22:03:26.077031 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 22:03:26.102914 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:26.112327 | 2025-02-25 22:03:26.112524 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 22:03:26.147046 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:26.154719 | 2025-02-25 22:03:26.154832 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 22:03:26.188984 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:26.205292 | 2025-02-25 22:03:26.205402 | TASK [emit-job-header : Print job information] 2025-02-25 22:03:26.318896 | # Job Information 2025-02-25 22:03:26.319140 | Ansible Version: 2.15.3 2025-02-25 22:03:26.319175 | Job: ansible-collection-ensure-readme 2025-02-25 22:03:26.319206 | Pipeline: check 2025-02-25 22:03:26.319227 | Executor: 7d211f194f6a 2025-02-25 22:03:26.319246 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/212 2025-02-25 22:03:26.319265 | Event ID: 85c46e30-f3c3-11ef-9d7f-8c54732f8656 2025-02-25 22:03:26.325731 | 2025-02-25 22:03:26.325838 | LOOP [emit-job-header : Print node information] 2025-02-25 22:03:26.467433 | ubuntu-noble | ok: 2025-02-25 22:03:26.467736 | ubuntu-noble | # Node Information 2025-02-25 22:03:26.467776 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 22:03:26.467801 | ubuntu-noble | Hostname: ubuntu 2025-02-25 22:03:26.467822 | ubuntu-noble | Username: zuul 2025-02-25 22:03:26.467842 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 22:03:26.467862 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 22:03:26.467882 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 22:03:26.467902 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 22:03:26.467923 | ubuntu-noble | Interface IP: 81.163.193.110 2025-02-25 22:03:26.499414 | 2025-02-25 22:03:26.499618 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 22:03:27.052456 | ubuntu-noble -> localhost | changed 2025-02-25 22:03:27.063975 | 2025-02-25 22:03:27.064325 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 22:03:28.136251 | ubuntu-noble -> localhost | changed 2025-02-25 22:03:28.159649 | 2025-02-25 22:03:28.159787 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 22:03:28.491875 | ubuntu-noble -> localhost | ok 2025-02-25 22:03:28.501337 | 2025-02-25 22:03:28.501455 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 22:03:28.532271 | ubuntu-noble | ok 2025-02-25 22:03:28.548740 | ubuntu-noble | included: /var/lib/zuul/builds/788f5a93963442baadd131a60a78b97b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 22:03:28.556685 | 2025-02-25 22:03:28.556798 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 22:03:29.374346 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 22:03:29.374609 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/788f5a93963442baadd131a60a78b97b/work/788f5a93963442baadd131a60a78b97b_id_rsa 2025-02-25 22:03:29.374649 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/788f5a93963442baadd131a60a78b97b/work/788f5a93963442baadd131a60a78b97b_id_rsa.pub 2025-02-25 22:03:29.374675 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 22:03:29.374698 | ubuntu-noble -> localhost | SHA256:BzyfzDa7PZW35ZtXweA7BonIhBjkoWd2bJa/c60lKlA zuul-build-sshkey 2025-02-25 22:03:29.374721 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 22:03:29.374748 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 22:03:29.374770 | ubuntu-noble -> localhost | | .+o . | 2025-02-25 22:03:29.374791 | ubuntu-noble -> localhost | | o.o..o . | 2025-02-25 22:03:29.374811 | ubuntu-noble -> localhost | | . = *o = . o o | 2025-02-25 22:03:29.374831 | ubuntu-noble -> localhost | | + +E.o B + . o | 2025-02-25 22:03:29.374851 | ubuntu-noble -> localhost | | . .S O . ...| 2025-02-25 22:03:29.374870 | ubuntu-noble -> localhost | | . .o.o +o +| 2025-02-25 22:03:29.374890 | ubuntu-noble -> localhost | | . o o.o...o+| 2025-02-25 22:03:29.374910 | ubuntu-noble -> localhost | | . + +o. .+| 2025-02-25 22:03:29.374930 | ubuntu-noble -> localhost | | .. .. .. oo| 2025-02-25 22:03:29.374949 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 22:03:29.374998 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.265860 2025-02-25 22:03:29.384658 | 2025-02-25 22:03:29.384780 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 22:03:29.417328 | ubuntu-noble | ok 2025-02-25 22:03:29.428787 | ubuntu-noble | included: /var/lib/zuul/builds/788f5a93963442baadd131a60a78b97b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 22:03:29.438782 | 2025-02-25 22:03:29.438883 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 22:03:29.463372 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:29.472619 | 2025-02-25 22:03:29.472741 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 22:03:30.175168 | ubuntu-noble | changed 2025-02-25 22:03:30.182853 | 2025-02-25 22:03:30.182957 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 22:03:30.492197 | ubuntu-noble | ok 2025-02-25 22:03:30.499701 | 2025-02-25 22:03:30.499810 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 22:03:31.284472 | ubuntu-noble | changed 2025-02-25 22:03:31.295539 | 2025-02-25 22:03:31.295663 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 22:03:32.037388 | ubuntu-noble | changed 2025-02-25 22:03:32.050052 | 2025-02-25 22:03:32.050184 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 22:03:32.076477 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:32.084359 | 2025-02-25 22:03:32.084588 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 22:03:32.540279 | ubuntu-noble -> localhost | changed 2025-02-25 22:03:32.554476 | 2025-02-25 22:03:32.554633 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 22:03:32.906957 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/788f5a93963442baadd131a60a78b97b/work/788f5a93963442baadd131a60a78b97b_id_rsa (zuul-build-sshkey) 2025-02-25 22:03:32.907305 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.010483 2025-02-25 22:03:32.928332 | 2025-02-25 22:03:32.928790 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 22:03:33.388152 | ubuntu-noble | ok 2025-02-25 22:03:33.396262 | 2025-02-25 22:03:33.396372 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 22:03:33.442549 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:03:33.458433 | 2025-02-25 22:03:33.458567 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 22:03:33.925666 | ubuntu-noble | ok 2025-02-25 22:03:33.953193 | 2025-02-25 22:03:33.953339 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 22:03:34.004371 | ubuntu-noble | ok 2025-02-25 22:03:34.011906 | 2025-02-25 22:03:34.012052 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 22:03:34.346473 | ubuntu-noble -> localhost | ok 2025-02-25 22:03:34.363323 | 2025-02-25 22:03:34.363516 | TASK [validate-host : Collect information about the host] 2025-02-25 22:03:35.605040 | ubuntu-noble | ok 2025-02-25 22:03:35.619316 | 2025-02-25 22:03:35.619431 | TASK [validate-host : Sanitize hostname] 2025-02-25 22:03:35.695154 | ubuntu-noble | ok 2025-02-25 22:03:35.702694 | 2025-02-25 22:03:35.702799 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 22:03:36.509800 | ubuntu-noble -> localhost | changed 2025-02-25 22:03:36.523189 | 2025-02-25 22:03:36.523360 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 22:03:37.051744 | ubuntu-noble | ok 2025-02-25 22:03:37.070163 | 2025-02-25 22:03:37.070311 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 22:03:38.123883 | ubuntu-noble -> localhost | changed 2025-02-25 22:03:38.150644 | 2025-02-25 22:03:38.150857 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 22:03:38.501815 | ubuntu-noble | ok 2025-02-25 22:03:38.509022 | 2025-02-25 22:03:38.509134 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 22:03:39.483383 | ubuntu-noble | changed: 2025-02-25 22:03:39.483620 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 22:03:39.483654 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 22:03:39.483678 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 22:03:39.483700 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-02-25 22:03:39.483721 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.010036 2025-02-25 22:03:50.094213 | 2025-02-25 22:03:50.094291 | TASK [upload-logs : Upload logs to log server] 2025-02-25 22:03:50.617274 | localhost | Output suppressed because no_log was given 2025-02-25 22:03:50.626280 | 2025-02-25 22:03:50.626645 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 22:03:50.787391 | localhost | skipping: Conditional result was False 2025-02-25 22:03:50.810342 | localhost | skipping: Conditional result was False 2025-02-25 22:03:50.818641 | 2025-02-25 22:03:50.818758 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 22:03:50.873682 | localhost | skipping: Conditional result was False 2025-02-25 22:03:50.873968 | 2025-02-25 22:03:50.888673 | localhost | skipping: Conditional result was False 2025-02-25 22:03:50.900529 | 2025-02-25 22:03:50.900641 | LOOP [upload-logs : Upload console log and json output]