2025-10-09 10:51:17.851671 | Job console starting 2025-10-09 10:51:17.862456 | Updating git repos 2025-10-09 10:51:17.915170 | Cloning repos into workspace 2025-10-09 10:51:18.016033 | Restoring repo states 2025-10-09 10:51:18.044718 | Merging changes 2025-10-09 10:51:18.685939 | Checking out repos 2025-10-09 10:51:18.748331 | Preparing playbooks 2025-10-09 10:51:19.395211 | Running Ansible setup 2025-10-09 10:51:24.398428 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-09 10:51:25.539582 | 2025-10-09 10:51:25.539756 | PLAY [Base pre] 2025-10-09 10:51:25.555634 | 2025-10-09 10:51:25.555772 | TASK [Setup log path fact] 2025-10-09 10:51:25.585684 | debian-bookworm | ok 2025-10-09 10:51:25.615923 | 2025-10-09 10:51:25.616090 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-09 10:51:25.656191 | debian-bookworm | ok 2025-10-09 10:51:25.667296 | 2025-10-09 10:51:25.667418 | TASK [emit-job-header : Print job information] 2025-10-09 10:51:25.726703 | # Job Information 2025-10-09 10:51:25.726920 | Ansible Version: 2.16.14 2025-10-09 10:51:25.726958 | Job: ansible-collection-ensure-readme 2025-10-09 10:51:25.726989 | Pipeline: check 2025-10-09 10:51:25.727011 | Executor: 521e9411259a 2025-10-09 10:51:25.727031 | Triggered by: https://github.com/osism/ansible-collection-services/pull/2004 2025-10-09 10:51:25.727052 | Event ID: dd8bc050-a4fd-11f0-877f-faf5f36bf6d1 2025-10-09 10:51:25.731935 | 2025-10-09 10:51:25.732050 | LOOP [emit-job-header : Print node information] 2025-10-09 10:51:25.864490 | debian-bookworm | ok: 2025-10-09 10:51:25.864757 | debian-bookworm | # Node Information 2025-10-09 10:51:25.864794 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-09 10:51:25.864820 | debian-bookworm | Hostname: debian 2025-10-09 10:51:25.864841 | debian-bookworm | Username: zuul 2025-10-09 10:51:25.864878 | debian-bookworm | Distro: Debian 12.12 2025-10-09 10:51:25.864910 | debian-bookworm | Provider: regiocloud-a 2025-10-09 10:51:25.864935 | debian-bookworm | Region: 2025-10-09 10:51:25.864957 | debian-bookworm | Label: debian-bookworm 2025-10-09 10:51:25.864977 | debian-bookworm | Product Name: OpenStack Nova 2025-10-09 10:51:25.864996 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe82:e2e4 2025-10-09 10:51:25.896085 | 2025-10-09 10:51:25.896238 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-09 10:51:26.682227 | debian-bookworm -> localhost | changed 2025-10-09 10:51:26.690399 | 2025-10-09 10:51:26.690529 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-09 10:51:28.070670 | debian-bookworm -> localhost | changed 2025-10-09 10:51:28.079366 | 2025-10-09 10:51:28.079453 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-09 10:51:28.457585 | debian-bookworm -> localhost | ok 2025-10-09 10:51:28.462402 | 2025-10-09 10:51:28.462488 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-09 10:51:28.509650 | debian-bookworm | ok 2025-10-09 10:51:28.526131 | debian-bookworm | included: /var/lib/zuul/builds/09b71c130e0348e690cc40d1ba93a1c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-09 10:51:28.531010 | 2025-10-09 10:51:28.531085 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-09 10:51:29.991180 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-09 10:51:29.991331 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/09b71c130e0348e690cc40d1ba93a1c4/work/09b71c130e0348e690cc40d1ba93a1c4_id_rsa 2025-10-09 10:51:29.991362 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/09b71c130e0348e690cc40d1ba93a1c4/work/09b71c130e0348e690cc40d1ba93a1c4_id_rsa.pub 2025-10-09 10:51:29.991383 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-09 10:51:29.991404 | debian-bookworm -> localhost | SHA256:YHEwzBeeXw/L7HOgzcxTuzBtWtrMrKPq/OHRGdUilY0 zuul-build-sshkey 2025-10-09 10:51:29.991429 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-09 10:51:29.991447 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-09 10:51:29.991464 | debian-bookworm -> localhost | | o+.o. .+ | 2025-10-09 10:51:29.991481 | debian-bookworm -> localhost | | o=.. .E..| 2025-10-09 10:51:29.991497 | debian-bookworm -> localhost | | o.o + o .| 2025-10-09 10:51:29.991513 | debian-bookworm -> localhost | | . . . + * . | 2025-10-09 10:51:29.991529 | debian-bookworm -> localhost | | S . * o | 2025-10-09 10:51:29.991550 | debian-bookworm -> localhost | | O * . | 2025-10-09 10:51:29.991568 | debian-bookworm -> localhost | | + & * | 2025-10-09 10:51:29.991584 | debian-bookworm -> localhost | | . . o./ . | 2025-10-09 10:51:29.991601 | debian-bookworm -> localhost | | .+o+.+o* | 2025-10-09 10:51:29.991617 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-09 10:51:29.991656 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.009594 2025-10-09 10:51:29.996608 | 2025-10-09 10:51:29.996681 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-09 10:51:30.022729 | debian-bookworm | ok 2025-10-09 10:51:30.032945 | debian-bookworm | included: /var/lib/zuul/builds/09b71c130e0348e690cc40d1ba93a1c4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-09 10:51:30.039971 | 2025-10-09 10:51:30.040039 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-09 10:51:30.065041 | debian-bookworm | skipping: Conditional result was False 2025-10-09 10:51:30.069428 | 2025-10-09 10:51:30.069499 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-09 10:51:30.723197 | debian-bookworm | changed 2025-10-09 10:51:30.727531 | 2025-10-09 10:51:30.727601 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-09 10:51:30.999605 | debian-bookworm | ok 2025-10-09 10:51:31.009310 | 2025-10-09 10:51:31.009529 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-09 10:51:31.635750 | debian-bookworm | changed 2025-10-09 10:51:31.644389 | 2025-10-09 10:51:31.644506 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-09 10:51:32.285814 | debian-bookworm | changed 2025-10-09 10:51:32.293678 | 2025-10-09 10:51:32.293806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-09 10:51:32.327929 | debian-bookworm | skipping: Conditional result was False 2025-10-09 10:51:32.338425 | 2025-10-09 10:51:32.338571 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-09 10:51:32.777190 | debian-bookworm -> localhost | changed 2025-10-09 10:51:32.787648 | 2025-10-09 10:51:32.787746 | TASK [add-build-sshkey : Add back temp key] 2025-10-09 10:51:33.076413 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/09b71c130e0348e690cc40d1ba93a1c4/work/09b71c130e0348e690cc40d1ba93a1c4_id_rsa (zuul-build-sshkey) 2025-10-09 10:51:33.076739 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010451 2025-10-09 10:51:33.087587 | 2025-10-09 10:51:33.087695 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-09 10:51:33.467158 | debian-bookworm | ok 2025-10-09 10:51:33.471977 | 2025-10-09 10:51:33.472067 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-09 10:51:33.497386 | debian-bookworm | skipping: Conditional result was False 2025-10-09 10:51:33.516889 | 2025-10-09 10:51:33.517015 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-09 10:51:33.949020 | debian-bookworm | ok 2025-10-09 10:51:33.959683 | 2025-10-09 10:51:33.959785 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-09 10:51:34.007253 | debian-bookworm | ok 2025-10-09 10:51:34.012189 | 2025-10-09 10:51:34.012279 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-09 10:51:34.277508 | debian-bookworm -> localhost | ok 2025-10-09 10:51:34.283735 | 2025-10-09 10:51:34.283830 | TASK [validate-host : Collect information about the host] 2025-10-09 10:51:35.381522 | debian-bookworm | ok 2025-10-09 10:51:35.402653 | 2025-10-09 10:51:35.402780 | TASK [validate-host : Sanitize hostname] 2025-10-09 10:51:35.504049 | debian-bookworm | ok 2025-10-09 10:51:35.534415 | 2025-10-09 10:51:35.534517 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-09 10:51:36.034933 | debian-bookworm -> localhost | changed 2025-10-09 10:51:36.040143 | 2025-10-09 10:51:36.040230 | TASK [validate-host : Collect information about zuul worker] 2025-10-09 10:51:36.450139 | debian-bookworm | ok 2025-10-09 10:51:36.454532 | 2025-10-09 10:51:36.454625 | TASK [validate-host : Write out all zuul information for each host] 2025-10-09 10:51:36.932231 | debian-bookworm -> localhost | changed 2025-10-09 10:51:36.941301 | 2025-10-09 10:51:36.941392 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-09 10:51:37.212749 | debian-bookworm | ok 2025-10-09 10:51:37.217820 | 2025-10-09 10:51:37.217933 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-09 10:51:38.294540 | debian-bookworm | changed: 2025-10-09 10:51:38.294709 | debian-bookworm | cd+++++++++ src/ 2025-10-09 10:51:38.294743 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-09 10:51:38.294768 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-09 10:51:38.294789 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-10-09 10:51:38.294811 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007793 2025-10-09 10:51:54.717050 | 2025-10-09 10:51:54.717223 | TASK [upload-logs : Upload logs to log server] 2025-10-09 10:51:55.273953 | localhost | Output suppressed because no_log was given 2025-10-09 10:51:55.276716 | 2025-10-09 10:51:55.276879 | LOOP [upload-logs : Compress console log and json output] 2025-10-09 10:51:55.326632 | localhost | skipping: Conditional result was False 2025-10-09 10:51:55.332892 | localhost | skipping: Conditional result was False 2025-10-09 10:51:55.347832 | 2025-10-09 10:51:55.348090 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-09 10:51:55.398752 | localhost | skipping: Conditional result was False 2025-10-09 10:51:55.399380 | 2025-10-09 10:51:55.402949 | localhost | skipping: Conditional result was False 2025-10-09 10:51:55.411279 | 2025-10-09 10:51:55.411488 | LOOP [upload-logs : Upload console log and json output]