2025-02-03 12:55:55.947309 | Job console starting... 2025-02-03 12:55:55.968194 | Updating repositories 2025-02-03 12:55:56.019394 | Preparing job workspace 2025-02-03 12:55:57.983408 | Running Ansible setup... 2025-02-03 12:56:03.240512 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-03 12:56:04.135372 | 2025-02-03 12:56:04.135539 | PLAY [Base pre] 2025-02-03 12:56:04.176368 | 2025-02-03 12:56:04.176578 | TASK [Setup log path fact] 2025-02-03 12:56:04.240049 | ubuntu-noble | ok 2025-02-03 12:56:04.314967 | 2025-02-03 12:56:04.315147 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-03 12:56:04.435242 | ubuntu-noble | ok 2025-02-03 12:56:04.442219 | 2025-02-03 12:56:04.442385 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-03 12:56:04.478595 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:04.486137 | 2025-02-03 12:56:04.486274 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-03 12:56:04.555827 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:04.564887 | 2025-02-03 12:56:04.565035 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-03 12:56:04.635943 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:04.643466 | 2025-02-03 12:56:04.643598 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-03 12:56:04.698624 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:04.706631 | 2025-02-03 12:56:04.706785 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-03 12:56:04.780634 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:04.808523 | 2025-02-03 12:56:04.808693 | TASK [emit-job-header : Print job information] 2025-02-03 12:56:04.921958 | # Job Information 2025-02-03 12:56:04.922245 | Ansible Version: 2.15.3 2025-02-03 12:56:04.922284 | Job: ansible-collection-ensure-readme 2025-02-03 12:56:04.922313 | Pipeline: check 2025-02-03 12:56:04.922349 | Executor: 7d211f194f6a 2025-02-03 12:56:04.922369 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1747 2025-02-03 12:56:04.922389 | Event ID: 303753c0-e22e-11ef-9394-e3ce4a15fab9 2025-02-03 12:56:04.937153 | 2025-02-03 12:56:04.937296 | LOOP [emit-job-header : Print node information] 2025-02-03 12:56:05.105844 | ubuntu-noble | ok: 2025-02-03 12:56:05.106096 | ubuntu-noble | # Node Information 2025-02-03 12:56:05.106137 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-03 12:56:05.106231 | ubuntu-noble | Hostname: ubuntu 2025-02-03 12:56:05.106257 | ubuntu-noble | Username: zuul 2025-02-03 12:56:05.106277 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-03 12:56:05.106298 | ubuntu-noble | Provider: regiocloud-a 2025-02-03 12:56:05.106318 | ubuntu-noble | Label: ubuntu-noble 2025-02-03 12:56:05.106380 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-03 12:56:05.106405 | ubuntu-noble | Interface IP: 81.163.192.219 2025-02-03 12:56:05.153427 | 2025-02-03 12:56:05.154431 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-03 12:56:05.930430 | ubuntu-noble -> localhost | changed 2025-02-03 12:56:05.939022 | 2025-02-03 12:56:05.939146 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-03 12:56:07.398732 | ubuntu-noble -> localhost | changed 2025-02-03 12:56:07.414650 | 2025-02-03 12:56:07.414789 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-03 12:56:07.840356 | ubuntu-noble -> localhost | ok 2025-02-03 12:56:07.848562 | 2025-02-03 12:56:07.848687 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-03 12:56:07.894898 | ubuntu-noble | ok 2025-02-03 12:56:07.926477 | ubuntu-noble | included: /var/lib/zuul/builds/0be2ec1589e74ae887ea579afcc53eee/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-03 12:56:07.948479 | 2025-02-03 12:56:07.948779 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-03 12:56:08.683084 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-03 12:56:08.683307 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0be2ec1589e74ae887ea579afcc53eee/work/0be2ec1589e74ae887ea579afcc53eee_id_rsa 2025-02-03 12:56:08.683364 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0be2ec1589e74ae887ea579afcc53eee/work/0be2ec1589e74ae887ea579afcc53eee_id_rsa.pub 2025-02-03 12:56:08.683391 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-03 12:56:08.683417 | ubuntu-noble -> localhost | SHA256:HC6YeIOcDqxXb+LUjC/0bHRJ5DofO+RODAnV4KW5Tgs zuul-build-sshkey 2025-02-03 12:56:08.683439 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-03 12:56:08.683464 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-03 12:56:08.683486 | ubuntu-noble -> localhost | | oo. | 2025-02-03 12:56:08.683506 | ubuntu-noble -> localhost | | o +o | 2025-02-03 12:56:08.683526 | ubuntu-noble -> localhost | | . +o. | 2025-02-03 12:56:08.683546 | ubuntu-noble -> localhost | |.. + + =o. | 2025-02-03 12:56:08.683565 | ubuntu-noble -> localhost | |..= E *oS. | 2025-02-03 12:56:08.683584 | ubuntu-noble -> localhost | |.o o.X+== | 2025-02-03 12:56:08.683604 | ubuntu-noble -> localhost | |. o.++B*oo | 2025-02-03 12:56:08.683624 | ubuntu-noble -> localhost | | . o.++.= | 2025-02-03 12:56:08.683644 | ubuntu-noble -> localhost | | .o.... | 2025-02-03 12:56:08.683664 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-03 12:56:08.683716 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.043554 2025-02-03 12:56:08.698584 | 2025-02-03 12:56:08.698712 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-03 12:56:08.751384 | ubuntu-noble | ok 2025-02-03 12:56:08.771258 | ubuntu-noble | included: /var/lib/zuul/builds/0be2ec1589e74ae887ea579afcc53eee/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-03 12:56:08.793323 | 2025-02-03 12:56:08.793479 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-03 12:56:08.818485 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:08.826308 | 2025-02-03 12:56:08.826458 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-03 12:56:09.542126 | ubuntu-noble | changed 2025-02-03 12:56:09.550890 | 2025-02-03 12:56:09.551012 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-03 12:56:09.874963 | ubuntu-noble | ok 2025-02-03 12:56:09.887436 | 2025-02-03 12:56:09.887577 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-03 12:56:10.615311 | ubuntu-noble | changed 2025-02-03 12:56:10.626260 | 2025-02-03 12:56:10.626458 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-03 12:56:11.336718 | ubuntu-noble | changed 2025-02-03 12:56:11.347068 | 2025-02-03 12:56:11.347197 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-03 12:56:11.373986 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:11.381588 | 2025-02-03 12:56:11.381707 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-03 12:56:11.834458 | ubuntu-noble -> localhost | changed 2025-02-03 12:56:11.856962 | 2025-02-03 12:56:11.857107 | TASK [add-build-sshkey : Add back temp key] 2025-02-03 12:56:12.281405 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0be2ec1589e74ae887ea579afcc53eee/work/0be2ec1589e74ae887ea579afcc53eee_id_rsa (zuul-build-sshkey) 2025-02-03 12:56:12.281817 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011683 2025-02-03 12:56:12.329773 | 2025-02-03 12:56:12.329910 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-03 12:56:12.772483 | ubuntu-noble | ok 2025-02-03 12:56:12.783410 | 2025-02-03 12:56:12.783544 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-03 12:56:12.849080 | ubuntu-noble | skipping: Conditional result was False 2025-02-03 12:56:12.863289 | 2025-02-03 12:56:12.863555 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-03 12:56:13.291020 | ubuntu-noble | ok 2025-02-03 12:56:13.305016 | 2025-02-03 12:56:13.305148 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-03 12:56:13.336194 | ubuntu-noble | ok 2025-02-03 12:56:13.342770 | 2025-02-03 12:56:13.342880 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-03 12:56:13.721233 | ubuntu-noble -> localhost | ok 2025-02-03 12:56:13.729768 | 2025-02-03 12:56:13.729925 | TASK [validate-host : Collect information about the host] 2025-02-03 12:56:14.967678 | ubuntu-noble | ok 2025-02-03 12:56:14.995919 | 2025-02-03 12:56:14.996068 | TASK [validate-host : Sanitize hostname] 2025-02-03 12:56:15.078460 | ubuntu-noble | ok 2025-02-03 12:56:15.084869 | 2025-02-03 12:56:15.084993 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-03 12:56:15.715885 | ubuntu-noble -> localhost | changed 2025-02-03 12:56:15.723541 | 2025-02-03 12:56:15.723657 | TASK [validate-host : Collect information about zuul worker] 2025-02-03 12:56:16.244009 | ubuntu-noble | ok 2025-02-03 12:56:16.256552 | 2025-02-03 12:56:16.256679 | TASK [validate-host : Write out all zuul information for each host] 2025-02-03 12:56:17.640848 | ubuntu-noble -> localhost | changed 2025-02-03 12:56:17.658415 | 2025-02-03 12:56:17.658547 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-03 12:56:17.995940 | ubuntu-noble | ok 2025-02-03 12:56:18.003654 | 2025-02-03 12:56:18.003784 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-03 12:56:19.264372 | ubuntu-noble | changed: 2025-02-03 12:56:19.264600 | ubuntu-noble | cd+++++++++ src/ 2025-02-03 12:56:19.264645 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-03 12:56:19.264678 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-03 12:56:19.264708 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-03 12:56:19.264736 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.010205 2025-02-03 12:56:37.574676 | 2025-02-03 12:56:37.574807 | TASK [upload-logs : Upload logs to log server] 2025-02-03 12:56:38.150708 | localhost | Output suppressed because no_log was given 2025-02-03 12:56:38.153915 | 2025-02-03 12:56:38.154023 | LOOP [upload-logs : Compress console log and json output] 2025-02-03 12:56:38.232049 | localhost | skipping: Conditional result was False 2025-02-03 12:56:38.256051 | localhost | skipping: Conditional result was False 2025-02-03 12:56:38.273692 | 2025-02-03 12:56:38.273863 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-03 12:56:38.359073 | localhost | skipping: Conditional result was False 2025-02-03 12:56:38.359514 | 2025-02-03 12:56:38.371903 | localhost | skipping: Conditional result was False 2025-02-03 12:56:38.387704 | 2025-02-03 12:56:38.387866 | LOOP [upload-logs : Upload console log and json output]