2025-05-19 19:52:26.474668 | Job console starting 2025-05-19 19:52:26.510588 | Updating git repos 2025-05-19 19:52:26.593408 | Cloning repos into workspace 2025-05-19 19:52:26.704902 | Restoring repo states 2025-05-19 19:52:26.733746 | Merging changes 2025-05-19 19:52:27.347111 | Checking out repos 2025-05-19 19:52:27.405378 | Preparing playbooks 2025-05-19 19:52:28.607129 | Running Ansible setup 2025-05-19 19:52:35.628007 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-19 19:52:37.603716 | 2025-05-19 19:52:37.603914 | PLAY [Base pre] 2025-05-19 19:52:37.623033 | 2025-05-19 19:52:37.623190 | TASK [Setup log path fact] 2025-05-19 19:52:37.665375 | debian-bookworm | ok 2025-05-19 19:52:37.716127 | 2025-05-19 19:52:37.716394 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-19 19:52:37.790549 | debian-bookworm | ok 2025-05-19 19:52:37.817805 | 2025-05-19 19:52:37.817984 | TASK [emit-job-header : Print job information] 2025-05-19 19:52:37.945860 | # Job Information 2025-05-19 19:52:37.946115 | Ansible Version: 2.16.14 2025-05-19 19:52:37.946152 | Job: ansible-collection-ensure-readme 2025-05-19 19:52:37.946187 | Pipeline: check 2025-05-19 19:52:37.946211 | Executor: 521e9411259a 2025-05-19 19:52:37.946268 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1847 2025-05-19 19:52:37.946292 | Event ID: c54db080-34ea-11f0-9722-1726e65d1d9a 2025-05-19 19:52:37.965873 | 2025-05-19 19:52:37.966035 | LOOP [emit-job-header : Print node information] 2025-05-19 19:52:38.267246 | debian-bookworm | ok: 2025-05-19 19:52:38.269273 | debian-bookworm | # Node Information 2025-05-19 19:52:38.270004 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-19 19:52:38.270420 | debian-bookworm | Hostname: debian 2025-05-19 19:52:38.271618 | debian-bookworm | Username: zuul 2025-05-19 19:52:38.272012 | debian-bookworm | Distro: Debian 12.11 2025-05-19 19:52:38.272409 | debian-bookworm | Provider: regiocloud-a 2025-05-19 19:52:38.272777 | debian-bookworm | Region: 2025-05-19 19:52:38.273143 | debian-bookworm | Label: debian-bookworm 2025-05-19 19:52:38.273570 | debian-bookworm | Product Name: OpenStack Nova 2025-05-19 19:52:38.274002 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed0:2f4c 2025-05-19 19:52:38.293505 | 2025-05-19 19:52:38.293681 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-19 19:52:39.755456 | debian-bookworm -> localhost | changed 2025-05-19 19:52:39.761455 | 2025-05-19 19:52:39.761551 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-19 19:52:41.929377 | debian-bookworm -> localhost | changed 2025-05-19 19:52:41.940140 | 2025-05-19 19:52:41.940263 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-19 19:52:43.143395 | debian-bookworm -> localhost | ok 2025-05-19 19:52:43.150354 | 2025-05-19 19:52:43.150463 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-19 19:52:43.223205 | debian-bookworm | ok 2025-05-19 19:52:43.293166 | debian-bookworm | included: /var/lib/zuul/builds/591ba9cd53044af09d6dfbfac028a15c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-19 19:52:43.318712 | 2025-05-19 19:52:43.318825 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-19 19:52:45.426050 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-19 19:52:45.426301 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/591ba9cd53044af09d6dfbfac028a15c/work/591ba9cd53044af09d6dfbfac028a15c_id_rsa 2025-05-19 19:52:45.426343 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/591ba9cd53044af09d6dfbfac028a15c/work/591ba9cd53044af09d6dfbfac028a15c_id_rsa.pub 2025-05-19 19:52:45.426370 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-19 19:52:45.426396 | debian-bookworm -> localhost | SHA256:44EawwdaXH1hzUhdbBCxjMfQfZu/mWp0O9CtWnqrygo zuul-build-sshkey 2025-05-19 19:52:45.426429 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-19 19:52:45.426452 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-19 19:52:45.426473 | debian-bookworm -> localhost | | .. .=B+B. | 2025-05-19 19:52:45.426495 | debian-bookworm -> localhost | | . . ..o==.+ .| 2025-05-19 19:52:45.426514 | debian-bookworm -> localhost | | + .. =. .o| 2025-05-19 19:52:45.426535 | debian-bookworm -> localhost | | + . . . o | 2025-05-19 19:52:45.426555 | debian-bookworm -> localhost | | . + o S . o| 2025-05-19 19:52:45.426578 | debian-bookworm -> localhost | | = . o o oo| 2025-05-19 19:52:45.426598 | debian-bookworm -> localhost | | . E . . +.=| 2025-05-19 19:52:45.426617 | debian-bookworm -> localhost | | . . +o* | 2025-05-19 19:52:45.426637 | debian-bookworm -> localhost | | ..o.==o..| 2025-05-19 19:52:45.426657 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-19 19:52:45.426708 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.097618 2025-05-19 19:52:45.433035 | 2025-05-19 19:52:45.433137 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-19 19:52:45.451862 | debian-bookworm | ok 2025-05-19 19:52:45.460999 | debian-bookworm | included: /var/lib/zuul/builds/591ba9cd53044af09d6dfbfac028a15c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-19 19:52:45.469899 | 2025-05-19 19:52:45.470003 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-19 19:52:45.494333 | debian-bookworm | skipping: Conditional result was False 2025-05-19 19:52:45.504332 | 2025-05-19 19:52:45.504481 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-19 19:52:46.124460 | debian-bookworm | changed 2025-05-19 19:52:46.132658 | 2025-05-19 19:52:46.132778 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-19 19:52:46.407378 | debian-bookworm | ok 2025-05-19 19:52:46.414658 | 2025-05-19 19:52:46.414785 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-19 19:52:47.087363 | debian-bookworm | changed 2025-05-19 19:52:47.099346 | 2025-05-19 19:52:47.099486 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-19 19:52:47.709744 | debian-bookworm | changed 2025-05-19 19:52:47.719000 | 2025-05-19 19:52:47.719104 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-19 19:52:47.733689 | debian-bookworm | skipping: Conditional result was False 2025-05-19 19:52:47.740038 | 2025-05-19 19:52:47.740136 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-19 19:52:48.241466 | debian-bookworm -> localhost | changed 2025-05-19 19:52:48.257997 | 2025-05-19 19:52:48.258117 | TASK [add-build-sshkey : Add back temp key] 2025-05-19 19:52:48.747979 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/591ba9cd53044af09d6dfbfac028a15c/work/591ba9cd53044af09d6dfbfac028a15c_id_rsa (zuul-build-sshkey) 2025-05-19 19:52:48.748303 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021991 2025-05-19 19:52:48.757299 | 2025-05-19 19:52:48.757434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-19 19:52:49.360682 | debian-bookworm | ok 2025-05-19 19:52:49.369135 | 2025-05-19 19:52:49.369302 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-19 19:52:49.406725 | debian-bookworm | skipping: Conditional result was False 2025-05-19 19:52:49.427597 | 2025-05-19 19:52:49.427736 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-19 19:52:50.012072 | debian-bookworm | ok 2025-05-19 19:52:50.023416 | 2025-05-19 19:52:50.023563 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-19 19:52:50.056023 | debian-bookworm | ok 2025-05-19 19:52:50.061880 | 2025-05-19 19:52:50.062003 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-19 19:52:50.713132 | debian-bookworm -> localhost | ok 2025-05-19 19:52:50.726959 | 2025-05-19 19:52:50.727945 | TASK [validate-host : Collect information about the host] 2025-05-19 19:52:51.865180 | debian-bookworm | ok 2025-05-19 19:52:51.889624 | 2025-05-19 19:52:51.890963 | TASK [validate-host : Sanitize hostname] 2025-05-19 19:52:52.048762 | debian-bookworm | ok 2025-05-19 19:52:52.110985 | 2025-05-19 19:52:52.111152 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-19 19:52:52.961074 | debian-bookworm -> localhost | changed 2025-05-19 19:52:52.972966 | 2025-05-19 19:52:52.973125 | TASK [validate-host : Collect information about zuul worker] 2025-05-19 19:52:53.439395 | debian-bookworm | ok 2025-05-19 19:52:53.444815 | 2025-05-19 19:52:53.444933 | TASK [validate-host : Write out all zuul information for each host] 2025-05-19 19:52:54.278984 | debian-bookworm -> localhost | changed 2025-05-19 19:52:54.289589 | 2025-05-19 19:52:54.289728 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-19 19:52:54.553447 | debian-bookworm | ok 2025-05-19 19:52:54.561925 | 2025-05-19 19:52:54.562085 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-19 19:52:56.128695 | debian-bookworm | changed: 2025-05-19 19:52:56.128950 | debian-bookworm | cd+++++++++ src/ 2025-05-19 19:52:56.128987 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-19 19:52:56.129012 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-19 19:52:56.129034 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-05-19 19:52:56.129055 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008341 2025-05-19 19:53:13.451338 | 2025-05-19 19:53:13.451466 | TASK [upload-logs : Upload logs to log server] 2025-05-19 19:53:14.061741 | localhost | Output suppressed because no_log was given 2025-05-19 19:53:14.066640 | 2025-05-19 19:53:14.066958 | LOOP [upload-logs : Compress console log and json output] 2025-05-19 19:53:14.127111 | localhost | skipping: Conditional result was False 2025-05-19 19:53:14.131692 | localhost | skipping: Conditional result was False 2025-05-19 19:53:14.145726 | 2025-05-19 19:53:14.145990 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-19 19:53:14.208683 | localhost | skipping: Conditional result was False 2025-05-19 19:53:14.209404 | 2025-05-19 19:53:14.212889 | localhost | skipping: Conditional result was False 2025-05-19 19:53:14.220718 | 2025-05-19 19:53:14.221013 | LOOP [upload-logs : Upload console log and json output]