2025-06-11 08:55:52.020692 | Job console starting 2025-06-11 08:55:52.056143 | Updating git repos 2025-06-11 08:55:52.125605 | Cloning repos into workspace 2025-06-11 08:55:52.198280 | Restoring repo states 2025-06-11 08:55:52.219269 | Merging changes 2025-06-11 08:55:52.871340 | Checking out repos 2025-06-11 08:55:52.922078 | Preparing playbooks 2025-06-11 08:55:53.810963 | Running Ansible setup 2025-06-11 08:55:59.566376 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-11 08:56:00.375432 | 2025-06-11 08:56:00.375610 | PLAY [Base pre] 2025-06-11 08:56:00.392383 | 2025-06-11 08:56:00.392544 | TASK [Setup log path fact] 2025-06-11 08:56:00.411939 | debian-bookworm | ok 2025-06-11 08:56:00.428743 | 2025-06-11 08:56:00.428916 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-11 08:56:00.461376 | debian-bookworm | ok 2025-06-11 08:56:00.474545 | 2025-06-11 08:56:00.474724 | TASK [emit-job-header : Print job information] 2025-06-11 08:56:00.515354 | # Job Information 2025-06-11 08:56:00.515549 | Ansible Version: 2.16.14 2025-06-11 08:56:00.515585 | Job: ansible-collection-ensure-readme 2025-06-11 08:56:00.515617 | Pipeline: check 2025-06-11 08:56:00.515639 | Executor: 521e9411259a 2025-06-11 08:56:00.515681 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1889 2025-06-11 08:56:00.515704 | Event ID: db3b7030-46a1-11f0-8e57-8aaa48f3eb33 2025-06-11 08:56:00.523401 | 2025-06-11 08:56:00.523534 | LOOP [emit-job-header : Print node information] 2025-06-11 08:56:00.659463 | debian-bookworm | ok: 2025-06-11 08:56:00.659874 | debian-bookworm | # Node Information 2025-06-11 08:56:00.659930 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-11 08:56:00.659956 | debian-bookworm | Hostname: debian 2025-06-11 08:56:00.659978 | debian-bookworm | Username: zuul 2025-06-11 08:56:00.659999 | debian-bookworm | Distro: Debian 12.11 2025-06-11 08:56:00.660023 | debian-bookworm | Provider: regiocloud-a 2025-06-11 08:56:00.660045 | debian-bookworm | Region: 2025-06-11 08:56:00.660066 | debian-bookworm | Label: debian-bookworm 2025-06-11 08:56:00.660085 | debian-bookworm | Product Name: OpenStack Nova 2025-06-11 08:56:00.660104 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1c:d00b 2025-06-11 08:56:00.678459 | 2025-06-11 08:56:00.678595 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-11 08:56:01.648469 | debian-bookworm -> localhost | changed 2025-06-11 08:56:01.656245 | 2025-06-11 08:56:01.656380 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-11 08:56:03.221858 | debian-bookworm -> localhost | changed 2025-06-11 08:56:03.238215 | 2025-06-11 08:56:03.238364 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-11 08:56:03.890023 | debian-bookworm -> localhost | ok 2025-06-11 08:56:03.898027 | 2025-06-11 08:56:03.898244 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-11 08:56:03.943288 | debian-bookworm | ok 2025-06-11 08:56:03.972961 | debian-bookworm | included: /var/lib/zuul/builds/d3edcdd95bff48ce982900c485312fd5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-11 08:56:03.990735 | 2025-06-11 08:56:03.990899 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-11 08:56:07.684640 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-11 08:56:07.684970 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d3edcdd95bff48ce982900c485312fd5/work/d3edcdd95bff48ce982900c485312fd5_id_rsa 2025-06-11 08:56:07.685011 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d3edcdd95bff48ce982900c485312fd5/work/d3edcdd95bff48ce982900c485312fd5_id_rsa.pub 2025-06-11 08:56:07.685037 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-11 08:56:07.685061 | debian-bookworm -> localhost | SHA256:QK05xnIkG6yl8mPG4aw0Vf87yMeDj7eY0Cx3HGfZOBs zuul-build-sshkey 2025-06-11 08:56:07.685095 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-11 08:56:07.685116 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-11 08:56:07.685137 | debian-bookworm -> localhost | | . .. | 2025-06-11 08:56:07.685158 | debian-bookworm -> localhost | | =o. . | 2025-06-11 08:56:07.685275 | debian-bookworm -> localhost | | +.*oo | 2025-06-11 08:56:07.685302 | debian-bookworm -> localhost | |. +.o Bo + | 2025-06-11 08:56:07.685324 | debian-bookworm -> localhost | | *.. + .S. E . | 2025-06-11 08:56:07.685353 | debian-bookworm -> localhost | | oO o ..+ + | 2025-06-11 08:56:07.685374 | debian-bookworm -> localhost | |.+.. o.++o.. | 2025-06-11 08:56:07.685395 | debian-bookworm -> localhost | |. ++=B | 2025-06-11 08:56:07.685417 | debian-bookworm -> localhost | | ++o+ | 2025-06-11 08:56:07.685437 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-11 08:56:07.685513 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.988164 2025-06-11 08:56:07.694755 | 2025-06-11 08:56:07.694893 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-11 08:56:07.726353 | debian-bookworm | ok 2025-06-11 08:56:07.738205 | debian-bookworm | included: /var/lib/zuul/builds/d3edcdd95bff48ce982900c485312fd5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-11 08:56:07.749819 | 2025-06-11 08:56:07.749947 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-11 08:56:07.780143 | debian-bookworm | skipping: Conditional result was False 2025-06-11 08:56:07.786758 | 2025-06-11 08:56:07.787294 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-11 08:56:08.419953 | debian-bookworm | changed 2025-06-11 08:56:08.435032 | 2025-06-11 08:56:08.435376 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-11 08:56:08.679514 | debian-bookworm | ok 2025-06-11 08:56:08.685784 | 2025-06-11 08:56:08.685895 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-11 08:56:09.346942 | debian-bookworm | changed 2025-06-11 08:56:09.353990 | 2025-06-11 08:56:09.354115 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-11 08:56:09.969021 | debian-bookworm | changed 2025-06-11 08:56:09.976509 | 2025-06-11 08:56:09.976634 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-11 08:56:10.015155 | debian-bookworm | skipping: Conditional result was False 2025-06-11 08:56:10.033196 | 2025-06-11 08:56:10.033384 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-11 08:56:10.619548 | debian-bookworm -> localhost | changed 2025-06-11 08:56:10.679169 | 2025-06-11 08:56:10.679333 | TASK [add-build-sshkey : Add back temp key] 2025-06-11 08:56:11.579883 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d3edcdd95bff48ce982900c485312fd5/work/d3edcdd95bff48ce982900c485312fd5_id_rsa (zuul-build-sshkey) 2025-06-11 08:56:11.580160 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012217 2025-06-11 08:56:11.588992 | 2025-06-11 08:56:11.589124 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-11 08:56:12.038404 | debian-bookworm | ok 2025-06-11 08:56:12.045038 | 2025-06-11 08:56:12.045178 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-11 08:56:12.128964 | debian-bookworm | skipping: Conditional result was False 2025-06-11 08:56:12.141251 | 2025-06-11 08:56:12.141391 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-11 08:56:12.700619 | debian-bookworm | ok 2025-06-11 08:56:12.716637 | 2025-06-11 08:56:12.716797 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-11 08:56:12.755261 | debian-bookworm | ok 2025-06-11 08:56:12.763103 | 2025-06-11 08:56:12.763238 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-11 08:56:13.169917 | debian-bookworm -> localhost | ok 2025-06-11 08:56:13.180200 | 2025-06-11 08:56:13.180331 | TASK [validate-host : Collect information about the host] 2025-06-11 08:56:14.635319 | debian-bookworm | ok 2025-06-11 08:56:14.653310 | 2025-06-11 08:56:14.653455 | TASK [validate-host : Sanitize hostname] 2025-06-11 08:56:14.780793 | debian-bookworm | ok 2025-06-11 08:56:14.829791 | 2025-06-11 08:56:14.829938 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-11 08:56:15.976839 | debian-bookworm -> localhost | changed 2025-06-11 08:56:15.983031 | 2025-06-11 08:56:15.983166 | TASK [validate-host : Collect information about zuul worker] 2025-06-11 08:56:16.493483 | debian-bookworm | ok 2025-06-11 08:56:16.505738 | 2025-06-11 08:56:16.505928 | TASK [validate-host : Write out all zuul information for each host] 2025-06-11 08:56:17.386604 | debian-bookworm -> localhost | changed 2025-06-11 08:56:17.401078 | 2025-06-11 08:56:17.401218 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-11 08:56:17.703143 | debian-bookworm | ok 2025-06-11 08:56:17.712292 | 2025-06-11 08:56:17.712426 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-11 08:56:18.913468 | debian-bookworm | changed: 2025-06-11 08:56:18.913742 | debian-bookworm | cd+++++++++ src/ 2025-06-11 08:56:18.913787 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-11 08:56:18.913829 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-11 08:56:18.913853 | debian-bookworm | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-06-11 08:56:18.913874 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007265 2025-06-11 08:56:36.106338 | 2025-06-11 08:56:36.106517 | TASK [upload-logs : Upload logs to log server] 2025-06-11 08:56:36.708882 | localhost | Output suppressed because no_log was given 2025-06-11 08:56:36.713216 | 2025-06-11 08:56:36.713435 | LOOP [upload-logs : Compress console log and json output] 2025-06-11 08:56:36.781106 | localhost | skipping: Conditional result was False 2025-06-11 08:56:36.786253 | localhost | skipping: Conditional result was False 2025-06-11 08:56:36.794262 | 2025-06-11 08:56:36.794376 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-11 08:56:36.850979 | localhost | skipping: Conditional result was False 2025-06-11 08:56:36.851549 | 2025-06-11 08:56:36.855088 | localhost | skipping: Conditional result was False 2025-06-11 08:56:36.861281 | 2025-06-11 08:56:36.861425 | LOOP [upload-logs : Upload console log and json output]