2025-09-23 16:41:06.337386 | Job console starting 2025-09-23 16:41:06.359344 | Updating git repos 2025-09-23 16:41:06.409081 | Cloning repos into workspace 2025-09-23 16:41:06.467207 | Restoring repo states 2025-09-23 16:41:06.479531 | Merging changes 2025-09-23 16:41:07.046456 | Checking out repos 2025-09-23 16:41:07.073243 | Preparing playbooks 2025-09-23 16:41:07.681687 | Running Ansible setup 2025-09-23 16:41:12.802393 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 16:41:13.853055 | 2025-09-23 16:41:13.853230 | PLAY [Base pre] 2025-09-23 16:41:13.870561 | 2025-09-23 16:41:13.870692 | TASK [Setup log path fact] 2025-09-23 16:41:13.900106 | debian-bookworm | ok 2025-09-23 16:41:13.915626 | 2025-09-23 16:41:13.915767 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 16:41:13.946167 | debian-bookworm | ok 2025-09-23 16:41:13.965375 | 2025-09-23 16:41:13.965512 | TASK [emit-job-header : Print job information] 2025-09-23 16:41:14.012144 | # Job Information 2025-09-23 16:41:14.012339 | Ansible Version: 2.16.14 2025-09-23 16:41:14.012374 | Job: ansible-collection-ensure-readme 2025-09-23 16:41:14.012407 | Pipeline: check 2025-09-23 16:41:14.012430 | Executor: 521e9411259a 2025-09-23 16:41:14.012451 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/244 2025-09-23 16:41:14.012472 | Event ID: 1500a7d0-989c-11f0-8334-07eca68b33ea 2025-09-23 16:41:14.017479 | 2025-09-23 16:41:14.017590 | LOOP [emit-job-header : Print node information] 2025-09-23 16:41:14.157658 | debian-bookworm | ok: 2025-09-23 16:41:14.158892 | debian-bookworm | # Node Information 2025-09-23 16:41:14.158978 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 16:41:14.159008 | debian-bookworm | Hostname: debian 2025-09-23 16:41:14.159065 | debian-bookworm | Username: zuul 2025-09-23 16:41:14.159088 | debian-bookworm | Distro: Debian 12.12 2025-09-23 16:41:14.159113 | debian-bookworm | Provider: regiocloud-a 2025-09-23 16:41:14.159134 | debian-bookworm | Region: 2025-09-23 16:41:14.159156 | debian-bookworm | Label: debian-bookworm 2025-09-23 16:41:14.159176 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 16:41:14.159195 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe13:d0c8 2025-09-23 16:41:14.189203 | 2025-09-23 16:41:14.189351 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 16:41:14.800839 | debian-bookworm -> localhost | changed 2025-09-23 16:41:14.808427 | 2025-09-23 16:41:14.808569 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 16:41:16.195943 | debian-bookworm -> localhost | changed 2025-09-23 16:41:16.206991 | 2025-09-23 16:41:16.207126 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 16:41:16.711161 | debian-bookworm -> localhost | ok 2025-09-23 16:41:16.716993 | 2025-09-23 16:41:16.717097 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 16:41:16.734361 | debian-bookworm | ok 2025-09-23 16:41:16.751715 | debian-bookworm | included: /var/lib/zuul/builds/16f26f142b464c77add6d0d5e4a9c1d2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 16:41:16.758192 | 2025-09-23 16:41:16.758279 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 16:41:18.694326 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 16:41:18.694501 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/16f26f142b464c77add6d0d5e4a9c1d2/work/16f26f142b464c77add6d0d5e4a9c1d2_id_rsa 2025-09-23 16:41:18.694539 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/16f26f142b464c77add6d0d5e4a9c1d2/work/16f26f142b464c77add6d0d5e4a9c1d2_id_rsa.pub 2025-09-23 16:41:18.694565 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 16:41:18.694589 | debian-bookworm -> localhost | SHA256:RtI0ojDV5jB0UWfr59j2IkfyNOqTyOW8WO48PqKyLv0 zuul-build-sshkey 2025-09-23 16:41:18.694618 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 16:41:18.694641 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 16:41:18.694662 | debian-bookworm -> localhost | | ooo.+o+ o | 2025-09-23 16:41:18.694683 | debian-bookworm -> localhost | | oooo+ + . | 2025-09-23 16:41:18.694704 | debian-bookworm -> localhost | | .=. o . | 2025-09-23 16:41:18.694724 | debian-bookworm -> localhost | | .o . | 2025-09-23 16:41:18.694744 | debian-bookworm -> localhost | | S . . | 2025-09-23 16:41:18.694772 | debian-bookworm -> localhost | | . o=+ | 2025-09-23 16:41:18.694792 | debian-bookworm -> localhost | | . . =oB+. | 2025-09-23 16:41:18.694812 | debian-bookworm -> localhost | | . o +=X.+. | 2025-09-23 16:41:18.694845 | debian-bookworm -> localhost | | oo+E..=BB .. | 2025-09-23 16:41:18.694867 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 16:41:18.694915 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.450652 2025-09-23 16:41:18.700823 | 2025-09-23 16:41:18.700907 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 16:41:18.728146 | debian-bookworm | ok 2025-09-23 16:41:18.740596 | debian-bookworm | included: /var/lib/zuul/builds/16f26f142b464c77add6d0d5e4a9c1d2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 16:41:18.749013 | 2025-09-23 16:41:18.749100 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 16:41:18.761738 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:41:18.767155 | 2025-09-23 16:41:18.767235 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 16:41:19.441099 | debian-bookworm | changed 2025-09-23 16:41:19.447598 | 2025-09-23 16:41:19.447711 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 16:41:19.713206 | debian-bookworm | ok 2025-09-23 16:41:19.721266 | 2025-09-23 16:41:19.721396 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 16:41:20.388930 | debian-bookworm | changed 2025-09-23 16:41:20.395556 | 2025-09-23 16:41:20.395656 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 16:41:21.046438 | debian-bookworm | changed 2025-09-23 16:41:21.054594 | 2025-09-23 16:41:21.054713 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 16:41:21.089104 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:41:21.099194 | 2025-09-23 16:41:21.099319 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 16:41:21.498263 | debian-bookworm -> localhost | changed 2025-09-23 16:41:21.508567 | 2025-09-23 16:41:21.508673 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 16:41:21.834881 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/16f26f142b464c77add6d0d5e4a9c1d2/work/16f26f142b464c77add6d0d5e4a9c1d2_id_rsa (zuul-build-sshkey) 2025-09-23 16:41:21.835115 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021872 2025-09-23 16:41:21.842533 | 2025-09-23 16:41:21.842625 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 16:41:22.335794 | debian-bookworm | ok 2025-09-23 16:41:22.340566 | 2025-09-23 16:41:22.340653 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 16:41:22.363412 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:41:22.373318 | 2025-09-23 16:41:22.373420 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 16:41:22.779210 | debian-bookworm | ok 2025-09-23 16:41:22.791935 | 2025-09-23 16:41:22.792078 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 16:41:22.834433 | debian-bookworm | ok 2025-09-23 16:41:22.841344 | 2025-09-23 16:41:22.841449 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 16:41:23.089854 | debian-bookworm -> localhost | ok 2025-09-23 16:41:23.096177 | 2025-09-23 16:41:23.096268 | TASK [validate-host : Collect information about the host] 2025-09-23 16:41:24.219729 | debian-bookworm | ok 2025-09-23 16:41:24.234449 | 2025-09-23 16:41:24.234550 | TASK [validate-host : Sanitize hostname] 2025-09-23 16:41:24.344306 | debian-bookworm | ok 2025-09-23 16:41:24.372843 | 2025-09-23 16:41:24.372984 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 16:41:24.973915 | debian-bookworm -> localhost | changed 2025-09-23 16:41:24.982308 | 2025-09-23 16:41:24.982433 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 16:41:25.414419 | debian-bookworm | ok 2025-09-23 16:41:25.422303 | 2025-09-23 16:41:25.422425 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 16:41:26.016719 | debian-bookworm -> localhost | changed 2025-09-23 16:41:26.027264 | 2025-09-23 16:41:26.027393 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 16:41:26.349065 | debian-bookworm | ok 2025-09-23 16:41:26.354818 | 2025-09-23 16:41:26.354942 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 16:41:27.318719 | debian-bookworm | changed: 2025-09-23 16:41:27.318928 | debian-bookworm | cd+++++++++ src/ 2025-09-23 16:41:27.318966 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 16:41:27.318990 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 16:41:27.319011 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-09-23 16:41:27.319051 | debian-bookworm | localhost | ok: Runtime: 0:00:00.003892 2025-09-23 16:41:35.855259 | 2025-09-23 16:41:35.855386 | TASK [upload-logs : Upload logs to log server] 2025-09-23 16:41:36.431130 | localhost | Output suppressed because no_log was given 2025-09-23 16:41:36.435193 | 2025-09-23 16:41:36.435398 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 16:41:36.494596 | localhost | skipping: Conditional result was False 2025-09-23 16:41:36.499528 | localhost | skipping: Conditional result was False 2025-09-23 16:41:36.513455 | 2025-09-23 16:41:36.513684 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 16:41:36.559504 | localhost | skipping: Conditional result was False 2025-09-23 16:41:36.560149 | 2025-09-23 16:41:36.563464 | localhost | skipping: Conditional result was False 2025-09-23 16:41:36.576707 | 2025-09-23 16:41:36.576943 | LOOP [upload-logs : Upload console log and json output]