2025-11-24 20:11:29.736829 | Job console starting 2025-11-24 20:11:29.774934 | Updating git repos 2025-11-24 20:11:29.843087 | Cloning repos into workspace 2025-11-24 20:11:29.927455 | Restoring repo states 2025-11-24 20:11:29.955128 | Merging changes 2025-11-24 20:11:30.672740 | Checking out repos 2025-11-24 20:11:30.760068 | Preparing playbooks 2025-11-24 20:11:31.616640 | Running Ansible setup 2025-11-24 20:11:36.706014 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-24 20:11:37.525081 | 2025-11-24 20:11:37.525254 | PLAY [Base pre] 2025-11-24 20:11:37.541693 | 2025-11-24 20:11:37.541852 | TASK [Setup log path fact] 2025-11-24 20:11:37.571180 | debian-bookworm | ok 2025-11-24 20:11:37.586769 | 2025-11-24 20:11:37.586948 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-24 20:11:37.616892 | debian-bookworm | ok 2025-11-24 20:11:37.638580 | 2025-11-24 20:11:37.638732 | TASK [emit-job-header : Print job information] 2025-11-24 20:11:37.708900 | # Job Information 2025-11-24 20:11:37.709084 | Ansible Version: 2.16.14 2025-11-24 20:11:37.709120 | Job: ansible-collection-ensure-readme 2025-11-24 20:11:37.709153 | Pipeline: check 2025-11-24 20:11:37.709176 | Executor: 521e9411259a 2025-11-24 20:11:37.709197 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2029 2025-11-24 20:11:37.709219 | Event ID: bde34140-c971-11f0-9335-02f0cce156d1 2025-11-24 20:11:37.714326 | 2025-11-24 20:11:37.714464 | LOOP [emit-job-header : Print node information] 2025-11-24 20:11:37.849291 | debian-bookworm | ok: 2025-11-24 20:11:37.849607 | debian-bookworm | # Node Information 2025-11-24 20:11:37.849648 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-24 20:11:37.849673 | debian-bookworm | Hostname: debian 2025-11-24 20:11:37.849695 | debian-bookworm | Username: zuul 2025-11-24 20:11:37.849716 | debian-bookworm | Distro: Debian 12.12 2025-11-24 20:11:37.849739 | debian-bookworm | Provider: regiocloud-a 2025-11-24 20:11:37.849759 | debian-bookworm | Region: 2025-11-24 20:11:37.849779 | debian-bookworm | Label: debian-bookworm 2025-11-24 20:11:37.849799 | debian-bookworm | Product Name: OpenStack Nova 2025-11-24 20:11:37.849883 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed7:c60f 2025-11-24 20:11:37.870708 | 2025-11-24 20:11:37.870882 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-24 20:11:38.706734 | debian-bookworm -> localhost | changed 2025-11-24 20:11:38.714365 | 2025-11-24 20:11:38.714543 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-24 20:11:40.336347 | debian-bookworm -> localhost | changed 2025-11-24 20:11:40.353476 | 2025-11-24 20:11:40.353624 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-24 20:11:40.818172 | debian-bookworm -> localhost | ok 2025-11-24 20:11:40.824591 | 2025-11-24 20:11:40.824719 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-24 20:11:40.864905 | debian-bookworm | ok 2025-11-24 20:11:40.907683 | debian-bookworm | included: /var/lib/zuul/builds/7246467a974149ba85bd93fbb63591bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-24 20:11:40.925040 | 2025-11-24 20:11:40.925177 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-24 20:11:42.722449 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-24 20:11:42.722684 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7246467a974149ba85bd93fbb63591bf/work/7246467a974149ba85bd93fbb63591bf_id_rsa 2025-11-24 20:11:42.722723 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7246467a974149ba85bd93fbb63591bf/work/7246467a974149ba85bd93fbb63591bf_id_rsa.pub 2025-11-24 20:11:42.722749 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-24 20:11:42.722774 | debian-bookworm -> localhost | SHA256:v5naphSbQDCIiP3+TUI09Fi992ZzFQvVqdBQpdM7Ejw zuul-build-sshkey 2025-11-24 20:11:42.722808 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-24 20:11:42.722946 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-24 20:11:42.722974 | debian-bookworm -> localhost | |oo .o.. .. .+.ooo| 2025-11-24 20:11:42.722997 | debian-bookworm -> localhost | |+ o oo+ ...ooo.| 2025-11-24 20:11:42.723017 | debian-bookworm -> localhost | | . .o.. ..Eo.o| 2025-11-24 20:11:42.723037 | debian-bookworm -> localhost | | ... . ..+.o| 2025-11-24 20:11:42.723058 | debian-bookworm -> localhost | | . .. S . o o.| 2025-11-24 20:11:42.723085 | debian-bookworm -> localhost | | . ...= * o| 2025-11-24 20:11:42.723105 | debian-bookworm -> localhost | | . ++ . o o | 2025-11-24 20:11:42.723126 | debian-bookworm -> localhost | | .....+ | 2025-11-24 20:11:42.723147 | debian-bookworm -> localhost | | o+= | 2025-11-24 20:11:42.723167 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-24 20:11:42.723223 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.960192 2025-11-24 20:11:42.729896 | 2025-11-24 20:11:42.730013 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-24 20:11:42.761832 | debian-bookworm | ok 2025-11-24 20:11:42.772067 | debian-bookworm | included: /var/lib/zuul/builds/7246467a974149ba85bd93fbb63591bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-24 20:11:42.799706 | 2025-11-24 20:11:42.799849 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-24 20:11:42.825303 | debian-bookworm | skipping: Conditional result was False 2025-11-24 20:11:42.831359 | 2025-11-24 20:11:42.831511 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-24 20:11:43.485124 | debian-bookworm | changed 2025-11-24 20:11:43.491887 | 2025-11-24 20:11:43.492000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-24 20:11:43.743655 | debian-bookworm | ok 2025-11-24 20:11:43.749329 | 2025-11-24 20:11:43.749462 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-24 20:11:44.436664 | debian-bookworm | changed 2025-11-24 20:11:44.443636 | 2025-11-24 20:11:44.443760 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-24 20:11:45.078032 | debian-bookworm | changed 2025-11-24 20:11:45.091910 | 2025-11-24 20:11:45.092033 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-24 20:11:45.116315 | debian-bookworm | skipping: Conditional result was False 2025-11-24 20:11:45.122681 | 2025-11-24 20:11:45.122799 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-24 20:11:45.757763 | debian-bookworm -> localhost | changed 2025-11-24 20:11:45.770635 | 2025-11-24 20:11:45.770809 | TASK [add-build-sshkey : Add back temp key] 2025-11-24 20:11:46.481042 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7246467a974149ba85bd93fbb63591bf/work/7246467a974149ba85bd93fbb63591bf_id_rsa (zuul-build-sshkey) 2025-11-24 20:11:46.481300 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023971 2025-11-24 20:11:46.489679 | 2025-11-24 20:11:46.489813 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-24 20:11:47.246512 | debian-bookworm | ok 2025-11-24 20:11:47.270512 | 2025-11-24 20:11:47.270668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-24 20:11:47.345153 | debian-bookworm | skipping: Conditional result was False 2025-11-24 20:11:47.356227 | 2025-11-24 20:11:47.356361 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-24 20:11:48.069726 | debian-bookworm | ok 2025-11-24 20:11:48.082322 | 2025-11-24 20:11:48.082477 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-24 20:11:48.130323 | debian-bookworm | ok 2025-11-24 20:11:48.135879 | 2025-11-24 20:11:48.135998 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-24 20:11:48.702031 | debian-bookworm -> localhost | ok 2025-11-24 20:11:48.708998 | 2025-11-24 20:11:48.709133 | TASK [validate-host : Collect information about the host] 2025-11-24 20:11:49.967814 | debian-bookworm | ok 2025-11-24 20:11:49.985143 | 2025-11-24 20:11:49.985304 | TASK [validate-host : Sanitize hostname] 2025-11-24 20:11:50.127622 | debian-bookworm | ok 2025-11-24 20:11:50.184694 | 2025-11-24 20:11:50.184849 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-24 20:11:50.810159 | debian-bookworm -> localhost | changed 2025-11-24 20:11:50.816340 | 2025-11-24 20:11:50.816476 | TASK [validate-host : Collect information about zuul worker] 2025-11-24 20:11:51.312583 | debian-bookworm | ok 2025-11-24 20:11:51.323184 | 2025-11-24 20:11:51.323327 | TASK [validate-host : Write out all zuul information for each host] 2025-11-24 20:11:51.964035 | debian-bookworm -> localhost | changed 2025-11-24 20:11:51.974328 | 2025-11-24 20:11:51.974492 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-24 20:11:52.243439 | debian-bookworm | ok 2025-11-24 20:11:52.249808 | 2025-11-24 20:11:52.249937 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-24 20:11:53.492602 | debian-bookworm | changed: 2025-11-24 20:11:53.492830 | debian-bookworm | cd+++++++++ src/ 2025-11-24 20:11:53.492868 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-24 20:11:53.492893 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-24 20:11:53.492915 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-11-24 20:11:53.492935 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007190 2025-11-24 20:12:11.170285 | 2025-11-24 20:12:11.170501 | TASK [upload-logs : Upload logs to log server] 2025-11-24 20:12:11.773441 | localhost | Output suppressed because no_log was given 2025-11-24 20:12:11.778572 | 2025-11-24 20:12:11.778785 | LOOP [upload-logs : Compress console log and json output] 2025-11-24 20:12:11.845231 | localhost | skipping: Conditional result was False 2025-11-24 20:12:11.850591 | localhost | skipping: Conditional result was False 2025-11-24 20:12:11.863723 | 2025-11-24 20:12:11.863964 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-24 20:12:11.914028 | localhost | skipping: Conditional result was False 2025-11-24 20:12:11.914684 | 2025-11-24 20:12:11.918366 | localhost | skipping: Conditional result was False 2025-11-24 20:12:11.927131 | 2025-11-24 20:12:11.927499 | LOOP [upload-logs : Upload console log and json output]