2025-10-07 16:29:49.434417 | Job console starting 2025-10-07 16:29:49.452530 | Updating git repos 2025-10-07 16:29:49.508360 | Cloning repos into workspace 2025-10-07 16:29:49.581415 | Restoring repo states 2025-10-07 16:29:49.611470 | Merging changes 2025-10-07 16:29:50.232584 | Checking out repos 2025-10-07 16:29:50.271917 | Preparing playbooks 2025-10-07 16:29:50.919416 | Running Ansible setup 2025-10-07 16:29:55.534909 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-07 16:29:56.366434 | 2025-10-07 16:29:56.366618 | PLAY [Base pre] 2025-10-07 16:29:56.382523 | 2025-10-07 16:29:56.382704 | TASK [Setup log path fact] 2025-10-07 16:29:56.412341 | debian-bookworm | ok 2025-10-07 16:29:56.433160 | 2025-10-07 16:29:56.433315 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-07 16:29:56.473406 | debian-bookworm | ok 2025-10-07 16:29:56.491847 | 2025-10-07 16:29:56.491984 | TASK [emit-job-header : Print job information] 2025-10-07 16:29:56.551543 | # Job Information 2025-10-07 16:29:56.551758 | Ansible Version: 2.16.14 2025-10-07 16:29:56.551794 | Job: ansible-collection-ensure-readme 2025-10-07 16:29:56.551827 | Pipeline: check 2025-10-07 16:29:56.551850 | Executor: 521e9411259a 2025-10-07 16:29:56.551871 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1981 2025-10-07 16:29:56.551893 | Event ID: d2c592e0-a39a-11f0-8958-f9836bf0f5b3 2025-10-07 16:29:56.556837 | 2025-10-07 16:29:56.556949 | LOOP [emit-job-header : Print node information] 2025-10-07 16:29:56.789977 | debian-bookworm | ok: 2025-10-07 16:29:56.790263 | debian-bookworm | # Node Information 2025-10-07 16:29:56.790300 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-07 16:29:56.790324 | debian-bookworm | Hostname: debian 2025-10-07 16:29:56.790345 | debian-bookworm | Username: zuul 2025-10-07 16:29:56.790365 | debian-bookworm | Distro: Debian 12.12 2025-10-07 16:29:56.790388 | debian-bookworm | Provider: regiocloud-a 2025-10-07 16:29:56.790409 | debian-bookworm | Region: 2025-10-07 16:29:56.790429 | debian-bookworm | Label: debian-bookworm 2025-10-07 16:29:56.790448 | debian-bookworm | Product Name: OpenStack Nova 2025-10-07 16:29:56.790468 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe78:41b8 2025-10-07 16:29:56.804336 | 2025-10-07 16:29:56.804463 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-07 16:29:57.556968 | debian-bookworm -> localhost | changed 2025-10-07 16:29:57.564338 | 2025-10-07 16:29:57.564459 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-07 16:29:58.991356 | debian-bookworm -> localhost | changed 2025-10-07 16:29:59.001670 | 2025-10-07 16:29:59.001831 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-07 16:29:59.273882 | debian-bookworm -> localhost | ok 2025-10-07 16:29:59.278970 | 2025-10-07 16:29:59.279055 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-07 16:29:59.305343 | debian-bookworm | ok 2025-10-07 16:29:59.331137 | debian-bookworm | included: /var/lib/zuul/builds/689676f29b734f14a57a22aa571ab8a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-07 16:29:59.336006 | 2025-10-07 16:29:59.336078 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-07 16:30:00.581333 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-07 16:30:00.581556 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/689676f29b734f14a57a22aa571ab8a0/work/689676f29b734f14a57a22aa571ab8a0_id_rsa 2025-10-07 16:30:00.581633 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/689676f29b734f14a57a22aa571ab8a0/work/689676f29b734f14a57a22aa571ab8a0_id_rsa.pub 2025-10-07 16:30:00.581661 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-07 16:30:00.581687 | debian-bookworm -> localhost | SHA256:mHZyYhV+I4Ha4Hag/jjL7AUNhWRETm6VLZUFFtWjdBE zuul-build-sshkey 2025-10-07 16:30:00.581718 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-07 16:30:00.581741 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-07 16:30:00.581762 | debian-bookworm -> localhost | | +*.o+=B=.Eo | 2025-10-07 16:30:00.581784 | debian-bookworm -> localhost | | =.o=.+..o+ | 2025-10-07 16:30:00.581804 | debian-bookworm -> localhost | | =o * .+oo. | 2025-10-07 16:30:00.581824 | debian-bookworm -> localhost | | ..o+ o+.o . | 2025-10-07 16:30:00.581843 | debian-bookworm -> localhost | | .....B S | 2025-10-07 16:30:00.581867 | debian-bookworm -> localhost | | .. o = | 2025-10-07 16:30:00.581888 | debian-bookworm -> localhost | | o. | 2025-10-07 16:30:00.581908 | debian-bookworm -> localhost | | oo.. | 2025-10-07 16:30:00.581928 | debian-bookworm -> localhost | | .=o | 2025-10-07 16:30:00.581948 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-07 16:30:00.581999 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.787557 2025-10-07 16:30:00.588333 | 2025-10-07 16:30:00.588438 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-07 16:30:00.607233 | debian-bookworm | ok 2025-10-07 16:30:00.622877 | debian-bookworm | included: /var/lib/zuul/builds/689676f29b734f14a57a22aa571ab8a0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-07 16:30:00.632576 | 2025-10-07 16:30:00.632667 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-07 16:30:00.665712 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:30:00.680906 | 2025-10-07 16:30:00.681014 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-07 16:30:01.348774 | debian-bookworm | changed 2025-10-07 16:30:01.353938 | 2025-10-07 16:30:01.354019 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-07 16:30:01.605668 | debian-bookworm | ok 2025-10-07 16:30:01.611881 | 2025-10-07 16:30:01.611967 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-07 16:30:02.242672 | debian-bookworm | changed 2025-10-07 16:30:02.264462 | 2025-10-07 16:30:02.264665 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-07 16:30:02.899722 | debian-bookworm | changed 2025-10-07 16:30:02.905924 | 2025-10-07 16:30:02.906018 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-07 16:30:02.929337 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:30:02.935864 | 2025-10-07 16:30:02.936235 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-07 16:30:03.441258 | debian-bookworm -> localhost | changed 2025-10-07 16:30:03.458052 | 2025-10-07 16:30:03.458190 | TASK [add-build-sshkey : Add back temp key] 2025-10-07 16:30:03.828249 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/689676f29b734f14a57a22aa571ab8a0/work/689676f29b734f14a57a22aa571ab8a0_id_rsa (zuul-build-sshkey) 2025-10-07 16:30:03.828461 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020978 2025-10-07 16:30:03.838646 | 2025-10-07 16:30:03.838744 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-07 16:30:04.296644 | debian-bookworm | ok 2025-10-07 16:30:04.301501 | 2025-10-07 16:30:04.301614 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-07 16:30:04.324756 | debian-bookworm | skipping: Conditional result was False 2025-10-07 16:30:04.334574 | 2025-10-07 16:30:04.334664 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-07 16:30:04.738530 | debian-bookworm | ok 2025-10-07 16:30:04.748662 | 2025-10-07 16:30:04.748746 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-07 16:30:04.788453 | debian-bookworm | ok 2025-10-07 16:30:04.794139 | 2025-10-07 16:30:04.794231 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-07 16:30:05.100459 | debian-bookworm -> localhost | ok 2025-10-07 16:30:05.106452 | 2025-10-07 16:30:05.106539 | TASK [validate-host : Collect information about the host] 2025-10-07 16:30:06.287563 | debian-bookworm | ok 2025-10-07 16:30:06.295591 | 2025-10-07 16:30:06.295676 | TASK [validate-host : Sanitize hostname] 2025-10-07 16:30:06.408416 | debian-bookworm | ok 2025-10-07 16:30:06.436266 | 2025-10-07 16:30:06.436369 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-07 16:30:06.995371 | debian-bookworm -> localhost | changed 2025-10-07 16:30:07.000901 | 2025-10-07 16:30:07.000993 | TASK [validate-host : Collect information about zuul worker] 2025-10-07 16:30:07.409200 | debian-bookworm | ok 2025-10-07 16:30:07.432800 | 2025-10-07 16:30:07.432988 | TASK [validate-host : Write out all zuul information for each host] 2025-10-07 16:30:08.024686 | debian-bookworm -> localhost | changed 2025-10-07 16:30:08.034264 | 2025-10-07 16:30:08.034382 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-07 16:30:08.328012 | debian-bookworm | ok 2025-10-07 16:30:08.337133 | 2025-10-07 16:30:08.337256 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-07 16:30:09.760181 | debian-bookworm | changed: 2025-10-07 16:30:09.760394 | debian-bookworm | cd+++++++++ src/ 2025-10-07 16:30:09.760430 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-07 16:30:09.760455 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-07 16:30:09.760477 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-07 16:30:09.760498 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004056 2025-10-07 16:30:26.386498 | 2025-10-07 16:30:26.386635 | TASK [upload-logs : Upload logs to log server] 2025-10-07 16:30:26.929059 | localhost | Output suppressed because no_log was given 2025-10-07 16:30:26.931066 | 2025-10-07 16:30:26.931178 | LOOP [upload-logs : Compress console log and json output] 2025-10-07 16:30:26.979165 | localhost | skipping: Conditional result was False 2025-10-07 16:30:26.983913 | localhost | skipping: Conditional result was False 2025-10-07 16:30:26.990647 | 2025-10-07 16:30:26.990991 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-07 16:30:27.035446 | localhost | skipping: Conditional result was False 2025-10-07 16:30:27.036126 | 2025-10-07 16:30:27.039365 | localhost | skipping: Conditional result was False 2025-10-07 16:30:27.052211 | 2025-10-07 16:30:27.052422 | LOOP [upload-logs : Upload console log and json output]