2025-09-11 08:48:35.325129 | Job console starting 2025-09-11 08:48:35.350705 | Updating git repos 2025-09-11 08:48:35.437340 | Cloning repos into workspace 2025-09-11 08:48:35.596087 | Restoring repo states 2025-09-11 08:48:35.643788 | Merging changes 2025-09-11 08:48:36.565044 | Checking out repos 2025-09-11 08:48:36.604316 | Preparing playbooks 2025-09-11 08:48:37.644970 | Running Ansible setup 2025-09-11 08:48:43.584080 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-11 08:48:44.857698 | 2025-09-11 08:48:44.857821 | PLAY [Base pre] 2025-09-11 08:48:44.885391 | 2025-09-11 08:48:44.885501 | TASK [Setup log path fact] 2025-09-11 08:48:44.936298 | debian-bookworm | ok 2025-09-11 08:48:44.948044 | 2025-09-11 08:48:44.968393 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-11 08:48:45.015887 | debian-bookworm | ok 2025-09-11 08:48:45.036829 | 2025-09-11 08:48:45.036930 | TASK [emit-job-header : Print job information] 2025-09-11 08:48:45.108559 | # Job Information 2025-09-11 08:48:45.108700 | Ansible Version: 2.16.14 2025-09-11 08:48:45.108729 | Job: ansible-collection-ensure-readme 2025-09-11 08:48:45.108757 | Pipeline: check 2025-09-11 08:48:45.108776 | Executor: 521e9411259a 2025-09-11 08:48:45.108793 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1976 2025-09-11 08:48:45.108812 | Event ID: 126413e0-8eec-11f0-9436-2ca664d02c92 2025-09-11 08:48:45.112711 | 2025-09-11 08:48:45.112786 | LOOP [emit-job-header : Print node information] 2025-09-11 08:48:45.338452 | debian-bookworm | ok: 2025-09-11 08:48:45.338738 | debian-bookworm | # Node Information 2025-09-11 08:48:45.338781 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-11 08:48:45.338806 | debian-bookworm | Hostname: debian 2025-09-11 08:48:45.338828 | debian-bookworm | Username: zuul 2025-09-11 08:48:45.338978 | debian-bookworm | Distro: Debian 12.12 2025-09-11 08:48:45.339006 | debian-bookworm | Provider: regiocloud-a 2025-09-11 08:48:45.339029 | debian-bookworm | Region: 2025-09-11 08:48:45.339051 | debian-bookworm | Label: debian-bookworm 2025-09-11 08:48:45.339071 | debian-bookworm | Product Name: OpenStack Nova 2025-09-11 08:48:45.339091 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8a:21d1 2025-09-11 08:48:45.356909 | 2025-09-11 08:48:45.356992 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-11 08:48:46.330405 | debian-bookworm -> localhost | changed 2025-09-11 08:48:46.337241 | 2025-09-11 08:48:46.337329 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-11 08:48:48.372379 | debian-bookworm -> localhost | changed 2025-09-11 08:48:48.382944 | 2025-09-11 08:48:48.383035 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-11 08:48:48.790866 | debian-bookworm -> localhost | ok 2025-09-11 08:48:48.796790 | 2025-09-11 08:48:48.796884 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-11 08:48:48.825310 | debian-bookworm | ok 2025-09-11 08:48:48.843583 | debian-bookworm | included: /var/lib/zuul/builds/a6eba0781dbd415cac5d01cf1f572d48/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-11 08:48:48.849281 | 2025-09-11 08:48:48.849363 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-11 08:48:52.933244 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-11 08:48:52.933472 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6eba0781dbd415cac5d01cf1f572d48/work/a6eba0781dbd415cac5d01cf1f572d48_id_rsa 2025-09-11 08:48:52.933505 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6eba0781dbd415cac5d01cf1f572d48/work/a6eba0781dbd415cac5d01cf1f572d48_id_rsa.pub 2025-09-11 08:48:52.933528 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-11 08:48:52.933548 | debian-bookworm -> localhost | SHA256:gtgs3PAIgVfYGvTzeJoVt1OB8tCvQx1n5cfrEunF56Q zuul-build-sshkey 2025-09-11 08:48:52.933576 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-11 08:48:52.933595 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-11 08:48:52.933612 | debian-bookworm -> localhost | |o..+. . .. .. | 2025-09-11 08:48:52.933630 | debian-bookworm -> localhost | |..+.. o o ..o. . | 2025-09-11 08:48:52.933647 | debian-bookworm -> localhost | |...oo .+.o.+ . o| 2025-09-11 08:48:52.933663 | debian-bookworm -> localhost | | o.O = oooo o..| 2025-09-11 08:48:52.933706 | debian-bookworm -> localhost | | = B =.S. o +o| 2025-09-11 08:48:52.933729 | debian-bookworm -> localhost | | . = .o. . ++.| 2025-09-11 08:48:52.933746 | debian-bookworm -> localhost | | o . oE..| 2025-09-11 08:48:52.933762 | debian-bookworm -> localhost | | . | 2025-09-11 08:48:52.933779 | debian-bookworm -> localhost | | | 2025-09-11 08:48:52.933796 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-11 08:48:52.933848 | debian-bookworm -> localhost | ok: Runtime: 0:00:03.286418 2025-09-11 08:48:52.940173 | 2025-09-11 08:48:52.940258 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-11 08:48:52.987867 | debian-bookworm | ok 2025-09-11 08:48:53.002443 | debian-bookworm | included: /var/lib/zuul/builds/a6eba0781dbd415cac5d01cf1f572d48/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-11 08:48:53.045577 | 2025-09-11 08:48:53.045698 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-11 08:48:53.084949 | debian-bookworm | skipping: Conditional result was False 2025-09-11 08:48:53.091171 | 2025-09-11 08:48:53.091262 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-11 08:48:53.947324 | debian-bookworm | changed 2025-09-11 08:48:53.952112 | 2025-09-11 08:48:53.952190 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-11 08:48:54.230700 | debian-bookworm | ok 2025-09-11 08:48:54.236231 | 2025-09-11 08:48:54.236313 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-11 08:48:54.957985 | debian-bookworm | changed 2025-09-11 08:48:54.970318 | 2025-09-11 08:48:54.970411 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-11 08:48:55.734250 | debian-bookworm | changed 2025-09-11 08:48:55.738678 | 2025-09-11 08:48:55.738752 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-11 08:48:55.776232 | debian-bookworm | skipping: Conditional result was False 2025-09-11 08:48:55.781168 | 2025-09-11 08:48:55.781246 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-11 08:48:56.493215 | debian-bookworm -> localhost | changed 2025-09-11 08:48:56.501970 | 2025-09-11 08:48:56.502051 | TASK [add-build-sshkey : Add back temp key] 2025-09-11 08:48:57.198962 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a6eba0781dbd415cac5d01cf1f572d48/work/a6eba0781dbd415cac5d01cf1f572d48_id_rsa (zuul-build-sshkey) 2025-09-11 08:48:57.199152 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011472 2025-09-11 08:48:57.205438 | 2025-09-11 08:48:57.205516 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-11 08:48:57.575182 | debian-bookworm | ok 2025-09-11 08:48:57.579408 | 2025-09-11 08:48:57.579488 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-11 08:48:57.612714 | debian-bookworm | skipping: Conditional result was False 2025-09-11 08:48:57.622331 | 2025-09-11 08:48:57.622422 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-11 08:48:58.067751 | debian-bookworm | ok 2025-09-11 08:48:58.086131 | 2025-09-11 08:48:58.086223 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-11 08:48:58.116978 | debian-bookworm | ok 2025-09-11 08:48:58.121308 | 2025-09-11 08:48:58.121397 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-11 08:48:58.633578 | debian-bookworm -> localhost | ok 2025-09-11 08:48:58.638745 | 2025-09-11 08:48:58.638817 | TASK [validate-host : Collect information about the host] 2025-09-11 08:48:59.816122 | debian-bookworm | ok 2025-09-11 08:48:59.839428 | 2025-09-11 08:48:59.839536 | TASK [validate-host : Sanitize hostname] 2025-09-11 08:49:00.013026 | debian-bookworm | ok 2025-09-11 08:49:00.133853 | 2025-09-11 08:49:00.133963 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-11 08:49:01.960054 | debian-bookworm -> localhost | changed 2025-09-11 08:49:01.965516 | 2025-09-11 08:49:01.965608 | TASK [validate-host : Collect information about zuul worker] 2025-09-11 08:49:02.642647 | debian-bookworm | ok 2025-09-11 08:49:02.648571 | 2025-09-11 08:49:02.648689 | TASK [validate-host : Write out all zuul information for each host] 2025-09-11 08:49:03.585234 | debian-bookworm -> localhost | changed 2025-09-11 08:49:03.593207 | 2025-09-11 08:49:03.593292 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-11 08:49:03.898430 | debian-bookworm | ok 2025-09-11 08:49:03.906869 | 2025-09-11 08:49:03.907011 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-11 08:49:04.942794 | debian-bookworm | changed: 2025-09-11 08:49:04.943248 | debian-bookworm | cd+++++++++ src/ 2025-09-11 08:49:04.943281 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-11 08:49:04.943302 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-11 08:49:04.943320 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-09-11 08:49:04.943337 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011391 2025-09-11 08:49:22.704853 | 2025-09-11 08:49:22.706176 | TASK [upload-logs : Upload logs to log server] 2025-09-11 08:49:23.428514 | localhost | Output suppressed because no_log was given 2025-09-11 08:49:23.430475 | 2025-09-11 08:49:23.430582 | LOOP [upload-logs : Compress console log and json output] 2025-09-11 08:49:23.537313 | localhost | skipping: Conditional result was False 2025-09-11 08:49:23.543580 | localhost | skipping: Conditional result was False 2025-09-11 08:49:23.551234 | 2025-09-11 08:49:23.551348 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-11 08:49:23.659418 | localhost | skipping: Conditional result was False 2025-09-11 08:49:23.659793 | 2025-09-11 08:49:23.664290 | localhost | skipping: Conditional result was False 2025-09-11 08:49:23.673402 | 2025-09-11 08:49:23.673525 | LOOP [upload-logs : Upload console log and json output]