2025-12-12 01:19:15.833201 | Job console starting 2025-12-12 01:19:15.857917 | Updating git repos 2025-12-12 01:19:15.889479 | Cloning repos into workspace 2025-12-12 01:19:15.951212 | Restoring repo states 2025-12-12 01:19:15.974258 | Merging changes 2025-12-12 01:19:16.565228 | Checking out repos 2025-12-12 01:19:16.683019 | Preparing playbooks 2025-12-12 01:19:17.346413 | Running Ansible setup 2025-12-12 01:19:22.078157 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-12 01:19:23.093580 | 2025-12-12 01:19:23.093795 | PLAY [Base pre] 2025-12-12 01:19:23.134302 | 2025-12-12 01:19:23.134564 | TASK [Setup log path fact] 2025-12-12 01:19:23.206743 | debian-bookworm | ok 2025-12-12 01:19:23.260786 | 2025-12-12 01:19:23.261011 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-12 01:19:23.360357 | debian-bookworm | ok 2025-12-12 01:19:23.384500 | 2025-12-12 01:19:23.384653 | TASK [emit-job-header : Print job information] 2025-12-12 01:19:23.500378 | # Job Information 2025-12-12 01:19:23.500633 | Ansible Version: 2.16.14 2025-12-12 01:19:23.500819 | Job: ansible-collection-ensure-readme 2025-12-12 01:19:23.500859 | Pipeline: check 2025-12-12 01:19:23.500882 | Executor: 521e9411259a 2025-12-12 01:19:23.500957 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1782 2025-12-12 01:19:23.500983 | Event ID: 53807260-d6ef-11f0-92ae-781fa456ee97 2025-12-12 01:19:23.507193 | 2025-12-12 01:19:23.507334 | LOOP [emit-job-header : Print node information] 2025-12-12 01:19:23.820080 | debian-bookworm | ok: 2025-12-12 01:19:23.820419 | debian-bookworm | # Node Information 2025-12-12 01:19:23.820463 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-12 01:19:23.820490 | debian-bookworm | Hostname: debian 2025-12-12 01:19:23.820513 | debian-bookworm | Username: zuul 2025-12-12 01:19:23.820535 | debian-bookworm | Distro: Debian 12.12 2025-12-12 01:19:23.820560 | debian-bookworm | Provider: regiocloud-a 2025-12-12 01:19:23.820582 | debian-bookworm | Region: 2025-12-12 01:19:23.820603 | debian-bookworm | Label: debian-bookworm 2025-12-12 01:19:23.820624 | debian-bookworm | Product Name: OpenStack Nova 2025-12-12 01:19:23.820644 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feed:845 2025-12-12 01:19:23.851873 | 2025-12-12 01:19:23.852039 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-12 01:19:24.639589 | debian-bookworm -> localhost | changed 2025-12-12 01:19:24.647750 | 2025-12-12 01:19:24.647889 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-12 01:19:25.958416 | debian-bookworm -> localhost | changed 2025-12-12 01:19:25.969711 | 2025-12-12 01:19:25.969848 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-12 01:19:26.269561 | debian-bookworm -> localhost | ok 2025-12-12 01:19:26.285193 | 2025-12-12 01:19:26.285391 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-12 01:19:26.319338 | debian-bookworm | ok 2025-12-12 01:19:26.343598 | debian-bookworm | included: /var/lib/zuul/builds/d5aebb40b6e34ef6a12b1668a9c97e76/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-12 01:19:26.350619 | 2025-12-12 01:19:26.350742 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-12 01:19:27.879011 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-12 01:19:27.879261 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d5aebb40b6e34ef6a12b1668a9c97e76/work/d5aebb40b6e34ef6a12b1668a9c97e76_id_rsa 2025-12-12 01:19:27.879476 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d5aebb40b6e34ef6a12b1668a9c97e76/work/d5aebb40b6e34ef6a12b1668a9c97e76_id_rsa.pub 2025-12-12 01:19:27.879511 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-12 01:19:27.879536 | debian-bookworm -> localhost | SHA256:crl2FivRjYzdrPg2mcmACA5vfI6mzxxtOtpXxcLxAKE zuul-build-sshkey 2025-12-12 01:19:27.879575 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-12 01:19:27.879598 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-12 01:19:27.879619 | debian-bookworm -> localhost | | oo | 2025-12-12 01:19:27.879640 | debian-bookworm -> localhost | | . o | 2025-12-12 01:19:27.879660 | debian-bookworm -> localhost | | E . = | 2025-12-12 01:19:27.879680 | debian-bookworm -> localhost | |. . o +* = | 2025-12-12 01:19:27.879699 | debian-bookworm -> localhost | | = . ..+S * + | 2025-12-12 01:19:27.879726 | debian-bookworm -> localhost | | =.o oo.+ + | 2025-12-12 01:19:27.879747 | debian-bookworm -> localhost | | ..+o. =o=+ | 2025-12-12 01:19:27.879766 | debian-bookworm -> localhost | | +++o . =B | 2025-12-12 01:19:27.879821 | debian-bookworm -> localhost | |o=*o ... | 2025-12-12 01:19:27.880081 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-12 01:19:27.880161 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.954815 2025-12-12 01:19:27.888296 | 2025-12-12 01:19:27.888442 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-12 01:19:27.926641 | debian-bookworm | ok 2025-12-12 01:19:27.938454 | debian-bookworm | included: /var/lib/zuul/builds/d5aebb40b6e34ef6a12b1668a9c97e76/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-12 01:19:27.948159 | 2025-12-12 01:19:27.948283 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-12 01:19:27.972275 | debian-bookworm | skipping: Conditional result was False 2025-12-12 01:19:27.978387 | 2025-12-12 01:19:27.978504 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-12 01:19:28.650429 | debian-bookworm | changed 2025-12-12 01:19:28.661643 | 2025-12-12 01:19:28.661780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-12 01:19:29.014993 | debian-bookworm | ok 2025-12-12 01:19:29.021344 | 2025-12-12 01:19:29.021491 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-12 01:19:29.740457 | debian-bookworm | changed 2025-12-12 01:19:29.749603 | 2025-12-12 01:19:29.749745 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-12 01:19:30.439401 | debian-bookworm | changed 2025-12-12 01:19:30.445494 | 2025-12-12 01:19:30.445626 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-12 01:19:30.479756 | debian-bookworm | skipping: Conditional result was False 2025-12-12 01:19:30.486151 | 2025-12-12 01:19:30.486269 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-12 01:19:31.061300 | debian-bookworm -> localhost | changed 2025-12-12 01:19:31.074298 | 2025-12-12 01:19:31.074435 | TASK [add-build-sshkey : Add back temp key] 2025-12-12 01:19:31.640561 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d5aebb40b6e34ef6a12b1668a9c97e76/work/d5aebb40b6e34ef6a12b1668a9c97e76_id_rsa (zuul-build-sshkey) 2025-12-12 01:19:31.640822 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014817 2025-12-12 01:19:31.650788 | 2025-12-12 01:19:31.651091 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-12 01:19:32.058570 | debian-bookworm | ok 2025-12-12 01:19:32.069099 | 2025-12-12 01:19:32.069267 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-12 01:19:32.109326 | debian-bookworm | skipping: Conditional result was False 2025-12-12 01:19:32.120915 | 2025-12-12 01:19:32.121045 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-12 01:19:32.623020 | debian-bookworm | ok 2025-12-12 01:19:32.643249 | 2025-12-12 01:19:32.643417 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-12 01:19:32.691476 | debian-bookworm | ok 2025-12-12 01:19:32.706297 | 2025-12-12 01:19:32.706452 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-12 01:19:33.070521 | debian-bookworm -> localhost | ok 2025-12-12 01:19:33.079299 | 2025-12-12 01:19:33.079431 | TASK [validate-host : Collect information about the host] 2025-12-12 01:19:34.313024 | debian-bookworm | ok 2025-12-12 01:19:34.339337 | 2025-12-12 01:19:34.339599 | TASK [validate-host : Sanitize hostname] 2025-12-12 01:19:34.548331 | debian-bookworm | ok 2025-12-12 01:19:34.615264 | 2025-12-12 01:19:34.615404 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-12 01:19:35.413739 | debian-bookworm -> localhost | changed 2025-12-12 01:19:35.419875 | 2025-12-12 01:19:35.420015 | TASK [validate-host : Collect information about zuul worker] 2025-12-12 01:19:35.847746 | debian-bookworm | ok 2025-12-12 01:19:35.853574 | 2025-12-12 01:19:35.853721 | TASK [validate-host : Write out all zuul information for each host] 2025-12-12 01:19:36.479202 | debian-bookworm -> localhost | changed 2025-12-12 01:19:36.491980 | 2025-12-12 01:19:36.492107 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-12 01:19:36.774087 | debian-bookworm | ok 2025-12-12 01:19:36.786033 | 2025-12-12 01:19:36.786168 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-12 01:19:38.032541 | debian-bookworm | changed: 2025-12-12 01:19:38.032774 | debian-bookworm | cd+++++++++ src/ 2025-12-12 01:19:38.032810 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-12 01:19:38.032835 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-12 01:19:38.032856 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-12-12 01:19:38.032877 | debian-bookworm | localhost | ok: Runtime: 0:00:00.014083 2025-12-12 01:20:01.521940 | 2025-12-12 01:20:01.522073 | TASK [upload-logs : Upload logs to log server] 2025-12-12 01:20:02.568293 | localhost | Output suppressed because no_log was given 2025-12-12 01:20:02.570257 | 2025-12-12 01:20:02.570368 | LOOP [upload-logs : Compress console log and json output] 2025-12-12 01:20:02.704095 | localhost | skipping: Conditional result was False 2025-12-12 01:20:02.719382 | localhost | skipping: Conditional result was False 2025-12-12 01:20:02.725695 | 2025-12-12 01:20:02.725839 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-12 01:20:02.937520 | localhost | skipping: Conditional result was False 2025-12-12 01:20:02.937871 | 2025-12-12 01:20:02.957951 | localhost | skipping: Conditional result was False 2025-12-12 01:20:02.962747 | 2025-12-12 01:20:02.962951 | LOOP [upload-logs : Upload console log and json output]