2025-06-25 13:27:20.339846 | Job console starting 2025-06-25 13:27:20.376653 | Updating git repos 2025-06-25 13:27:20.447842 | Cloning repos into workspace 2025-06-25 13:27:20.503736 | Restoring repo states 2025-06-25 13:27:20.520460 | Merging changes 2025-06-25 13:27:21.156108 | Checking out repos 2025-06-25 13:27:21.201900 | Preparing playbooks 2025-06-25 13:27:22.189336 | Running Ansible setup 2025-06-25 13:27:28.186031 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-25 13:27:29.199510 | 2025-06-25 13:27:29.199698 | PLAY [Base pre] 2025-06-25 13:27:29.226780 | 2025-06-25 13:27:29.226985 | TASK [Setup log path fact] 2025-06-25 13:27:29.260251 | debian-bookworm | ok 2025-06-25 13:27:29.275352 | 2025-06-25 13:27:29.275507 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-25 13:27:29.305708 | debian-bookworm | ok 2025-06-25 13:27:29.317729 | 2025-06-25 13:27:29.317893 | TASK [emit-job-header : Print job information] 2025-06-25 13:27:29.357417 | # Job Information 2025-06-25 13:27:29.357601 | Ansible Version: 2.16.14 2025-06-25 13:27:29.357639 | Job: ansible-collection-ensure-readme 2025-06-25 13:27:29.357672 | Pipeline: check 2025-06-25 13:27:29.357697 | Executor: 521e9411259a 2025-06-25 13:27:29.357719 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1920 2025-06-25 13:27:29.357741 | Event ID: 19f5bed0-51c8-11f0-9667-149b646fd815 2025-06-25 13:27:29.376259 | 2025-06-25 13:27:29.376409 | LOOP [emit-job-header : Print node information] 2025-06-25 13:27:29.529700 | debian-bookworm | ok: 2025-06-25 13:27:29.529951 | debian-bookworm | # Node Information 2025-06-25 13:27:29.529989 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-25 13:27:29.530015 | debian-bookworm | Hostname: debian 2025-06-25 13:27:29.530037 | debian-bookworm | Username: zuul 2025-06-25 13:27:29.530058 | debian-bookworm | Distro: Debian 12.11 2025-06-25 13:27:29.530081 | debian-bookworm | Provider: regiocloud-a 2025-06-25 13:27:29.530103 | debian-bookworm | Region: 2025-06-25 13:27:29.530124 | debian-bookworm | Label: debian-bookworm 2025-06-25 13:27:29.530144 | debian-bookworm | Product Name: OpenStack Nova 2025-06-25 13:27:29.530164 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe15:eba4 2025-06-25 13:27:29.543179 | 2025-06-25 13:27:29.543307 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-25 13:27:30.338079 | debian-bookworm -> localhost | changed 2025-06-25 13:27:30.345628 | 2025-06-25 13:27:30.345767 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-25 13:27:32.043663 | debian-bookworm -> localhost | changed 2025-06-25 13:27:32.076066 | 2025-06-25 13:27:32.076235 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-25 13:27:32.576939 | debian-bookworm -> localhost | ok 2025-06-25 13:27:32.592359 | 2025-06-25 13:27:32.592507 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-25 13:27:32.638379 | debian-bookworm | ok 2025-06-25 13:27:32.661301 | debian-bookworm | included: /var/lib/zuul/builds/de8646bd447a48eeaa2b15ed1ba3c3f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-25 13:27:32.667589 | 2025-06-25 13:27:32.667693 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-25 13:27:35.591807 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-25 13:27:35.592034 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/de8646bd447a48eeaa2b15ed1ba3c3f2/work/de8646bd447a48eeaa2b15ed1ba3c3f2_id_rsa 2025-06-25 13:27:35.592073 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/de8646bd447a48eeaa2b15ed1ba3c3f2/work/de8646bd447a48eeaa2b15ed1ba3c3f2_id_rsa.pub 2025-06-25 13:27:35.592099 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-25 13:27:35.592121 | debian-bookworm -> localhost | SHA256:lsiKyiXjrXyr7oEvfv43M98T6bFdaNjgyzRTmwegrFw zuul-build-sshkey 2025-06-25 13:27:35.592151 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-25 13:27:35.592173 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-25 13:27:35.592194 | debian-bookworm -> localhost | | | 2025-06-25 13:27:35.592215 | debian-bookworm -> localhost | | . | 2025-06-25 13:27:35.592235 | debian-bookworm -> localhost | | . . . | 2025-06-25 13:27:35.592255 | debian-bookworm -> localhost | | . . E . o | 2025-06-25 13:27:35.592275 | debian-bookworm -> localhost | | + S . * = | 2025-06-25 13:27:35.592300 | debian-bookworm -> localhost | |. . . + X * o | 2025-06-25 13:27:35.592320 | debian-bookworm -> localhost | |.+... + X o | 2025-06-25 13:27:35.592339 | debian-bookworm -> localhost | |=o*o = .* . | 2025-06-25 13:27:35.592359 | debian-bookworm -> localhost | |=@B+o.. =. .. | 2025-06-25 13:27:35.592379 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-25 13:27:35.592434 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.093616 2025-06-25 13:27:35.598822 | 2025-06-25 13:27:35.598953 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-25 13:27:35.628441 | debian-bookworm | ok 2025-06-25 13:27:35.638440 | debian-bookworm | included: /var/lib/zuul/builds/de8646bd447a48eeaa2b15ed1ba3c3f2/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-25 13:27:35.645987 | 2025-06-25 13:27:35.646067 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-25 13:27:35.658746 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:27:35.663311 | 2025-06-25 13:27:35.663381 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-25 13:27:36.319823 | debian-bookworm | changed 2025-06-25 13:27:36.325129 | 2025-06-25 13:27:36.325211 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-25 13:27:36.560276 | debian-bookworm | ok 2025-06-25 13:27:36.568482 | 2025-06-25 13:27:36.568671 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-25 13:27:37.210213 | debian-bookworm | changed 2025-06-25 13:27:37.216653 | 2025-06-25 13:27:37.216743 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-25 13:27:37.868421 | debian-bookworm | changed 2025-06-25 13:27:37.873939 | 2025-06-25 13:27:37.874030 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-25 13:27:37.887138 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:27:37.893062 | 2025-06-25 13:27:37.893154 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-25 13:27:38.390533 | debian-bookworm -> localhost | changed 2025-06-25 13:27:38.401180 | 2025-06-25 13:27:38.401277 | TASK [add-build-sshkey : Add back temp key] 2025-06-25 13:27:38.782715 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/de8646bd447a48eeaa2b15ed1ba3c3f2/work/de8646bd447a48eeaa2b15ed1ba3c3f2_id_rsa (zuul-build-sshkey) 2025-06-25 13:27:38.782986 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011222 2025-06-25 13:27:38.792110 | 2025-06-25 13:27:38.792203 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-25 13:27:39.255716 | debian-bookworm | ok 2025-06-25 13:27:39.262696 | 2025-06-25 13:27:39.262789 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-25 13:27:39.298311 | debian-bookworm | skipping: Conditional result was False 2025-06-25 13:27:39.309475 | 2025-06-25 13:27:39.309570 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-25 13:27:39.718939 | debian-bookworm | ok 2025-06-25 13:27:39.731790 | 2025-06-25 13:27:39.732035 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-25 13:27:39.767281 | debian-bookworm | ok 2025-06-25 13:27:39.772173 | 2025-06-25 13:27:39.772266 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-25 13:27:40.171992 | debian-bookworm -> localhost | ok 2025-06-25 13:27:40.182346 | 2025-06-25 13:27:40.182476 | TASK [validate-host : Collect information about the host] 2025-06-25 13:27:41.503982 | debian-bookworm | ok 2025-06-25 13:27:41.517345 | 2025-06-25 13:27:41.517477 | TASK [validate-host : Sanitize hostname] 2025-06-25 13:27:41.629183 | debian-bookworm | ok 2025-06-25 13:27:41.672835 | 2025-06-25 13:27:41.672993 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-25 13:27:42.800505 | debian-bookworm -> localhost | changed 2025-06-25 13:27:42.806499 | 2025-06-25 13:27:42.806617 | TASK [validate-host : Collect information about zuul worker] 2025-06-25 13:27:43.394603 | debian-bookworm | ok 2025-06-25 13:27:43.406715 | 2025-06-25 13:27:43.406919 | TASK [validate-host : Write out all zuul information for each host] 2025-06-25 13:27:44.171335 | debian-bookworm -> localhost | changed 2025-06-25 13:27:44.188936 | 2025-06-25 13:27:44.189135 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-25 13:27:44.503369 | debian-bookworm | ok 2025-06-25 13:27:44.509797 | 2025-06-25 13:27:44.509932 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-25 13:27:45.705728 | debian-bookworm | changed: 2025-06-25 13:27:45.705926 | debian-bookworm | cd+++++++++ src/ 2025-06-25 13:27:45.705965 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-25 13:27:45.705990 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-25 13:27:45.706013 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-06-25 13:27:45.706034 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004436 2025-06-25 13:28:01.911082 | 2025-06-25 13:28:01.911239 | TASK [upload-logs : Upload logs to log server] 2025-06-25 13:28:02.456745 | localhost | Output suppressed because no_log was given 2025-06-25 13:28:02.459537 | 2025-06-25 13:28:02.459680 | LOOP [upload-logs : Compress console log and json output] 2025-06-25 13:28:02.520534 | localhost | skipping: Conditional result was False 2025-06-25 13:28:02.524982 | localhost | skipping: Conditional result was False 2025-06-25 13:28:02.532432 | 2025-06-25 13:28:02.532672 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-25 13:28:02.577276 | localhost | skipping: Conditional result was False 2025-06-25 13:28:02.577901 | 2025-06-25 13:28:02.581047 | localhost | skipping: Conditional result was False 2025-06-25 13:28:02.595290 | 2025-06-25 13:28:02.595519 | LOOP [upload-logs : Upload console log and json output]