2025-11-12 22:47:48.518442 | Job console starting 2025-11-12 22:47:48.540695 | Updating git repos 2025-11-12 22:47:48.577751 | Cloning repos into workspace 2025-11-12 22:47:48.639893 | Restoring repo states 2025-11-12 22:47:48.653557 | Merging changes 2025-11-12 22:47:49.208072 | Checking out repos 2025-11-12 22:47:49.241042 | Preparing playbooks 2025-11-12 22:47:50.066719 | Running Ansible setup 2025-11-12 22:47:55.232819 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-12 22:47:56.196796 | 2025-11-12 22:47:56.196979 | PLAY [Base pre] 2025-11-12 22:47:56.216886 | 2025-11-12 22:47:56.217035 | TASK [Setup log path fact] 2025-11-12 22:47:56.260337 | debian-bookworm | ok 2025-11-12 22:47:56.276761 | 2025-11-12 22:47:56.276925 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-12 22:47:56.342701 | debian-bookworm | ok 2025-11-12 22:47:56.377070 | 2025-11-12 22:47:56.377233 | TASK [emit-job-header : Print job information] 2025-11-12 22:47:56.450772 | # Job Information 2025-11-12 22:47:56.451084 | Ansible Version: 2.16.14 2025-11-12 22:47:56.451127 | Job: ansible-collection-ensure-readme 2025-11-12 22:47:56.451162 | Pipeline: check 2025-11-12 22:47:56.451186 | Executor: 521e9411259a 2025-11-12 22:47:56.451207 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/247 2025-11-12 22:47:56.451231 | Event ID: 95ca8bc0-c019-11f0-9afe-c7299eaf0c3e 2025-11-12 22:47:56.457533 | 2025-11-12 22:47:56.457675 | LOOP [emit-job-header : Print node information] 2025-11-12 22:47:56.565273 | debian-bookworm | ok: 2025-11-12 22:47:56.565653 | debian-bookworm | # Node Information 2025-11-12 22:47:56.565698 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-12 22:47:56.565725 | debian-bookworm | Hostname: debian 2025-11-12 22:47:56.565759 | debian-bookworm | Username: zuul 2025-11-12 22:47:56.565783 | debian-bookworm | Distro: Debian 12.12 2025-11-12 22:47:56.565807 | debian-bookworm | Provider: regiocloud-a 2025-11-12 22:47:56.565828 | debian-bookworm | Region: 2025-11-12 22:47:56.565849 | debian-bookworm | Label: debian-bookworm 2025-11-12 22:47:56.565869 | debian-bookworm | Product Name: OpenStack Nova 2025-11-12 22:47:56.565889 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec0:4d4d 2025-11-12 22:47:56.586531 | 2025-11-12 22:47:56.586667 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-12 22:47:57.151694 | debian-bookworm -> localhost | changed 2025-11-12 22:47:57.159447 | 2025-11-12 22:47:57.159594 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-12 22:47:58.675494 | debian-bookworm -> localhost | changed 2025-11-12 22:47:58.687264 | 2025-11-12 22:47:58.687439 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-12 22:47:58.995514 | debian-bookworm -> localhost | ok 2025-11-12 22:47:59.002676 | 2025-11-12 22:47:59.002814 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-12 22:47:59.031853 | debian-bookworm | ok 2025-11-12 22:47:59.054394 | debian-bookworm | included: /var/lib/zuul/builds/98507ecc1e684148815d9e72f41cacdb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-12 22:47:59.061379 | 2025-11-12 22:47:59.061507 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-12 22:48:00.381773 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-12 22:48:00.382033 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/98507ecc1e684148815d9e72f41cacdb/work/98507ecc1e684148815d9e72f41cacdb_id_rsa 2025-11-12 22:48:00.382077 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/98507ecc1e684148815d9e72f41cacdb/work/98507ecc1e684148815d9e72f41cacdb_id_rsa.pub 2025-11-12 22:48:00.382104 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-12 22:48:00.382131 | debian-bookworm -> localhost | SHA256:o+vbHYUqlIN1xy2D3EeFSZmpZAR2l3Hw4+aE6/CxgKQ zuul-build-sshkey 2025-11-12 22:48:00.382167 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-12 22:48:00.382190 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-12 22:48:00.382212 | debian-bookworm -> localhost | | ooo.*@o | 2025-11-12 22:48:00.382234 | debian-bookworm -> localhost | | o =o+Bo | 2025-11-12 22:48:00.382254 | debian-bookworm -> localhost | | . +o*.o o | 2025-11-12 22:48:00.382274 | debian-bookworm -> localhost | | o o ..= o . | 2025-11-12 22:48:00.382311 | debian-bookworm -> localhost | | . + S . o + | 2025-11-12 22:48:00.382335 | debian-bookworm -> localhost | | . = + . = | 2025-11-12 22:48:00.382356 | debian-bookworm -> localhost | | E o + o . | 2025-11-12 22:48:00.382376 | debian-bookworm -> localhost | | + . * o | 2025-11-12 22:48:00.382398 | debian-bookworm -> localhost | | .+.. . + | 2025-11-12 22:48:00.382419 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-12 22:48:00.382482 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.574497 2025-11-12 22:48:00.389145 | 2025-11-12 22:48:00.389250 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-12 22:48:00.427771 | debian-bookworm | ok 2025-11-12 22:48:00.437389 | debian-bookworm | included: /var/lib/zuul/builds/98507ecc1e684148815d9e72f41cacdb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-12 22:48:00.458492 | 2025-11-12 22:48:00.458628 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-12 22:48:00.483354 | debian-bookworm | skipping: Conditional result was False 2025-11-12 22:48:00.492680 | 2025-11-12 22:48:00.492797 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-12 22:48:01.244404 | debian-bookworm | changed 2025-11-12 22:48:01.251790 | 2025-11-12 22:48:01.251922 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-12 22:48:01.517183 | debian-bookworm | ok 2025-11-12 22:48:01.523131 | 2025-11-12 22:48:01.523248 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-12 22:48:02.175448 | debian-bookworm | changed 2025-11-12 22:48:02.184647 | 2025-11-12 22:48:02.184783 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-12 22:48:02.860752 | debian-bookworm | changed 2025-11-12 22:48:02.868917 | 2025-11-12 22:48:02.869047 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-12 22:48:02.893912 | debian-bookworm | skipping: Conditional result was False 2025-11-12 22:48:02.905357 | 2025-11-12 22:48:02.905603 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-12 22:48:03.482620 | debian-bookworm -> localhost | changed 2025-11-12 22:48:03.493758 | 2025-11-12 22:48:03.493894 | TASK [add-build-sshkey : Add back temp key] 2025-11-12 22:48:03.901789 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/98507ecc1e684148815d9e72f41cacdb/work/98507ecc1e684148815d9e72f41cacdb_id_rsa (zuul-build-sshkey) 2025-11-12 22:48:03.902046 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020172 2025-11-12 22:48:03.916553 | 2025-11-12 22:48:03.916759 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-12 22:48:04.397630 | debian-bookworm | ok 2025-11-12 22:48:04.406621 | 2025-11-12 22:48:04.406780 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-12 22:48:04.457030 | debian-bookworm | skipping: Conditional result was False 2025-11-12 22:48:04.467875 | 2025-11-12 22:48:04.468003 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-12 22:48:04.923784 | debian-bookworm | ok 2025-11-12 22:48:04.935851 | 2025-11-12 22:48:04.935993 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-12 22:48:04.965697 | debian-bookworm | ok 2025-11-12 22:48:04.971144 | 2025-11-12 22:48:04.971272 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-12 22:48:05.315967 | debian-bookworm -> localhost | ok 2025-11-12 22:48:05.323211 | 2025-11-12 22:48:05.323359 | TASK [validate-host : Collect information about the host] 2025-11-12 22:48:06.481752 | debian-bookworm | ok 2025-11-12 22:48:06.502787 | 2025-11-12 22:48:06.503051 | TASK [validate-host : Sanitize hostname] 2025-11-12 22:48:06.612213 | debian-bookworm | ok 2025-11-12 22:48:06.663144 | 2025-11-12 22:48:06.663313 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-12 22:48:07.316807 | debian-bookworm -> localhost | changed 2025-11-12 22:48:07.323622 | 2025-11-12 22:48:07.323751 | TASK [validate-host : Collect information about zuul worker] 2025-11-12 22:48:07.818347 | debian-bookworm | ok 2025-11-12 22:48:07.823996 | 2025-11-12 22:48:07.824140 | TASK [validate-host : Write out all zuul information for each host] 2025-11-12 22:48:08.416701 | debian-bookworm -> localhost | changed 2025-11-12 22:48:08.427015 | 2025-11-12 22:48:08.427133 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-12 22:48:08.716688 | debian-bookworm | ok 2025-11-12 22:48:08.726324 | 2025-11-12 22:48:08.726475 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-12 22:48:09.564984 | debian-bookworm | changed: 2025-11-12 22:48:09.565247 | debian-bookworm | cd+++++++++ src/ 2025-11-12 22:48:09.565332 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-12 22:48:09.565374 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-12 22:48:09.565403 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-11-12 22:48:09.565430 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006898 2025-11-12 22:48:18.501965 | 2025-11-12 22:48:18.502155 | TASK [upload-logs : Upload logs to log server] 2025-11-12 22:48:19.104399 | localhost | Output suppressed because no_log was given 2025-11-12 22:48:19.108677 | 2025-11-12 22:48:19.108891 | LOOP [upload-logs : Compress console log and json output] 2025-11-12 22:48:19.172196 | localhost | skipping: Conditional result was False 2025-11-12 22:48:19.177698 | localhost | skipping: Conditional result was False 2025-11-12 22:48:19.192709 | 2025-11-12 22:48:19.192991 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-12 22:48:19.241703 | localhost | skipping: Conditional result was False 2025-11-12 22:48:19.242030 | 2025-11-12 22:48:19.247003 | localhost | skipping: Conditional result was False 2025-11-12 22:48:19.255669 | 2025-11-12 22:48:19.255916 | LOOP [upload-logs : Upload console log and json output]