2025-07-02 07:44:25.442868 | Job console starting 2025-07-02 07:44:25.461379 | Updating git repos 2025-07-02 07:44:25.552198 | Cloning repos into workspace 2025-07-02 07:44:25.637729 | Restoring repo states 2025-07-02 07:44:25.665705 | Merging changes 2025-07-02 07:44:26.244154 | Checking out repos 2025-07-02 07:44:26.281582 | Preparing playbooks 2025-07-02 07:44:26.924350 | Running Ansible setup 2025-07-02 07:44:32.670414 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-07-02 07:44:33.705431 | 2025-07-02 07:44:33.705592 | PLAY [Base pre] 2025-07-02 07:44:33.755845 | 2025-07-02 07:44:33.756002 | TASK [Setup log path fact] 2025-07-02 07:44:33.797810 | debian-bookworm | ok 2025-07-02 07:44:33.831340 | 2025-07-02 07:44:33.831540 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-07-02 07:44:33.862252 | debian-bookworm | ok 2025-07-02 07:44:33.872515 | 2025-07-02 07:44:33.872639 | TASK [emit-job-header : Print job information] 2025-07-02 07:44:33.912409 | # Job Information 2025-07-02 07:44:33.912604 | Ansible Version: 2.16.14 2025-07-02 07:44:33.912640 | Job: ansible-collection-ensure-readme 2025-07-02 07:44:33.912673 | Pipeline: check 2025-07-02 07:44:33.912695 | Executor: 521e9411259a 2025-07-02 07:44:33.912716 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1935 2025-07-02 07:44:33.912738 | Event ID: 59bfa990-5718-11f0-8a97-07d6a473dacf 2025-07-02 07:44:33.917744 | 2025-07-02 07:44:33.917855 | LOOP [emit-job-header : Print node information] 2025-07-02 07:44:34.049924 | debian-bookworm | ok: 2025-07-02 07:44:34.050187 | debian-bookworm | # Node Information 2025-07-02 07:44:34.050223 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-07-02 07:44:34.050249 | debian-bookworm | Hostname: debian 2025-07-02 07:44:34.050272 | debian-bookworm | Username: zuul 2025-07-02 07:44:34.050293 | debian-bookworm | Distro: Debian 12.11 2025-07-02 07:44:34.050316 | debian-bookworm | Provider: regiocloud-a 2025-07-02 07:44:34.050352 | debian-bookworm | Region: 2025-07-02 07:44:34.050373 | debian-bookworm | Label: debian-bookworm 2025-07-02 07:44:34.050394 | debian-bookworm | Product Name: OpenStack Nova 2025-07-02 07:44:34.050413 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8f:791c 2025-07-02 07:44:34.072597 | 2025-07-02 07:44:34.072742 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-07-02 07:44:35.124126 | debian-bookworm -> localhost | changed 2025-07-02 07:44:35.133372 | 2025-07-02 07:44:35.133498 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-07-02 07:44:37.194569 | debian-bookworm -> localhost | changed 2025-07-02 07:44:37.214287 | 2025-07-02 07:44:37.214462 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-07-02 07:44:37.677290 | debian-bookworm -> localhost | ok 2025-07-02 07:44:37.687971 | 2025-07-02 07:44:37.688243 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-07-02 07:44:37.760464 | debian-bookworm | ok 2025-07-02 07:44:37.826261 | debian-bookworm | included: /var/lib/zuul/builds/d90418ddccae451894bb91f14538c062/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-07-02 07:44:37.834778 | 2025-07-02 07:44:37.834962 | TASK [add-build-sshkey : Create Temp SSH key] 2025-07-02 07:44:41.927700 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-07-02 07:44:41.928653 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d90418ddccae451894bb91f14538c062/work/d90418ddccae451894bb91f14538c062_id_rsa 2025-07-02 07:44:41.928706 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d90418ddccae451894bb91f14538c062/work/d90418ddccae451894bb91f14538c062_id_rsa.pub 2025-07-02 07:44:41.928733 | debian-bookworm -> localhost | The key fingerprint is: 2025-07-02 07:44:41.928904 | debian-bookworm -> localhost | SHA256:64U+UdjbJ43TqTmMwsVo0yXOiKpEyjwdwcOtDIJhU5w zuul-build-sshkey 2025-07-02 07:44:41.929375 | debian-bookworm -> localhost | The key's randomart image is: 2025-07-02 07:44:41.930116 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-07-02 07:44:41.930307 | debian-bookworm -> localhost | |.oo.. | 2025-07-02 07:44:41.930622 | debian-bookworm -> localhost | |o.+E. | 2025-07-02 07:44:41.931057 | debian-bookworm -> localhost | |o. = . o | 2025-07-02 07:44:41.931240 | debian-bookworm -> localhost | |. o + . + . | 2025-07-02 07:44:41.932222 | debian-bookworm -> localhost | | .+ .SO = + . | 2025-07-02 07:44:41.932289 | debian-bookworm -> localhost | |oo. . . *oB = = | 2025-07-02 07:44:41.932347 | debian-bookworm -> localhost | |.+.. . oo+.o * | 2025-07-02 07:44:41.932375 | debian-bookworm -> localhost | | .. . o+.. = | 2025-07-02 07:44:41.932399 | debian-bookworm -> localhost | | .. oo . | 2025-07-02 07:44:41.932420 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-07-02 07:44:41.932485 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.664348 2025-07-02 07:44:42.012192 | 2025-07-02 07:44:42.012407 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-07-02 07:44:42.055731 | debian-bookworm | ok 2025-07-02 07:44:42.068979 | debian-bookworm | included: /var/lib/zuul/builds/d90418ddccae451894bb91f14538c062/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-07-02 07:44:42.098138 | 2025-07-02 07:44:42.098319 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-07-02 07:44:42.117379 | debian-bookworm | skipping: Conditional result was False 2025-07-02 07:44:42.139241 | 2025-07-02 07:44:42.139381 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-07-02 07:44:42.774167 | debian-bookworm | changed 2025-07-02 07:44:42.780516 | 2025-07-02 07:44:42.780607 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-07-02 07:44:43.031808 | debian-bookworm | ok 2025-07-02 07:44:43.036985 | 2025-07-02 07:44:43.037073 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-07-02 07:44:43.664919 | debian-bookworm | changed 2025-07-02 07:44:43.683131 | 2025-07-02 07:44:43.683250 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-07-02 07:44:44.390395 | debian-bookworm | changed 2025-07-02 07:44:44.400602 | 2025-07-02 07:44:44.400695 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-07-02 07:44:44.433522 | debian-bookworm | skipping: Conditional result was False 2025-07-02 07:44:44.439675 | 2025-07-02 07:44:44.439818 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-07-02 07:44:44.926706 | debian-bookworm -> localhost | changed 2025-07-02 07:44:44.952761 | 2025-07-02 07:44:44.952868 | TASK [add-build-sshkey : Add back temp key] 2025-07-02 07:44:45.352125 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d90418ddccae451894bb91f14538c062/work/d90418ddccae451894bb91f14538c062_id_rsa (zuul-build-sshkey) 2025-07-02 07:44:45.352413 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024073 2025-07-02 07:44:45.364201 | 2025-07-02 07:44:45.364316 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-07-02 07:44:45.754012 | debian-bookworm | ok 2025-07-02 07:44:45.764912 | 2025-07-02 07:44:45.765134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-07-02 07:44:45.801433 | debian-bookworm | skipping: Conditional result was False 2025-07-02 07:44:45.815379 | 2025-07-02 07:44:45.815490 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-07-02 07:44:46.246346 | debian-bookworm | ok 2025-07-02 07:44:46.264082 | 2025-07-02 07:44:46.264198 | TASK [validate-host : Define zuul_info_dir fact] 2025-07-02 07:44:46.292797 | debian-bookworm | ok 2025-07-02 07:44:46.300486 | 2025-07-02 07:44:46.300580 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-07-02 07:44:46.557609 | debian-bookworm -> localhost | ok 2025-07-02 07:44:46.571631 | 2025-07-02 07:44:46.571782 | TASK [validate-host : Collect information about the host] 2025-07-02 07:44:47.687635 | debian-bookworm | ok 2025-07-02 07:44:47.711050 | 2025-07-02 07:44:47.713790 | TASK [validate-host : Sanitize hostname] 2025-07-02 07:44:47.815213 | debian-bookworm | ok 2025-07-02 07:44:47.865138 | 2025-07-02 07:44:47.865254 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-07-02 07:44:48.571641 | debian-bookworm -> localhost | changed 2025-07-02 07:44:48.581941 | 2025-07-02 07:44:48.582401 | TASK [validate-host : Collect information about zuul worker] 2025-07-02 07:44:49.029192 | debian-bookworm | ok 2025-07-02 07:44:49.034019 | 2025-07-02 07:44:49.034132 | TASK [validate-host : Write out all zuul information for each host] 2025-07-02 07:44:49.738590 | debian-bookworm -> localhost | changed 2025-07-02 07:44:49.757267 | 2025-07-02 07:44:49.757417 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-07-02 07:44:50.062684 | debian-bookworm | ok 2025-07-02 07:44:50.068797 | 2025-07-02 07:44:50.068921 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-07-02 07:44:51.161620 | debian-bookworm | changed: 2025-07-02 07:44:51.161866 | debian-bookworm | cd+++++++++ src/ 2025-07-02 07:44:51.161914 | debian-bookworm | cd+++++++++ src/github.com/ 2025-07-02 07:44:51.161946 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-07-02 07:44:51.161975 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-07-02 07:44:51.162005 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005309 2025-07-02 07:45:08.085917 | 2025-07-02 07:45:08.086075 | TASK [upload-logs : Upload logs to log server] 2025-07-02 07:45:08.712866 | localhost | Output suppressed because no_log was given 2025-07-02 07:45:08.715995 | 2025-07-02 07:45:08.716149 | LOOP [upload-logs : Compress console log and json output] 2025-07-02 07:45:08.765633 | localhost | skipping: Conditional result was False 2025-07-02 07:45:08.774174 | localhost | skipping: Conditional result was False 2025-07-02 07:45:08.798757 | 2025-07-02 07:45:08.798962 | LOOP [upload-logs : Upload compressed console log and json output] 2025-07-02 07:45:08.862893 | localhost | skipping: Conditional result was False 2025-07-02 07:45:08.863319 | 2025-07-02 07:45:08.878607 | localhost | skipping: Conditional result was False 2025-07-02 07:45:08.887949 | 2025-07-02 07:45:08.888136 | LOOP [upload-logs : Upload console log and json output]