2025-02-22 02:42:42.851955 | Job console starting... 2025-02-22 02:42:42.900597 | Updating repositories 2025-02-22 02:42:43.007815 | Preparing job workspace 2025-02-22 02:42:46.540503 | Running Ansible setup... 2025-02-22 02:42:54.853551 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-22 02:42:56.331306 | 2025-02-22 02:42:56.331438 | PLAY [Base pre] 2025-02-22 02:42:56.381848 | 2025-02-22 02:42:56.381987 | TASK [Setup log path fact] 2025-02-22 02:42:56.413990 | ubuntu-noble | ok 2025-02-22 02:42:56.437242 | 2025-02-22 02:42:56.437369 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-22 02:42:56.526031 | ubuntu-noble | ok 2025-02-22 02:42:56.536783 | 2025-02-22 02:42:56.536900 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-22 02:42:56.614306 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:42:56.621320 | 2025-02-22 02:42:56.621429 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-22 02:42:56.663162 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:42:56.670994 | 2025-02-22 02:42:56.671107 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-22 02:42:56.715142 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:42:56.722205 | 2025-02-22 02:42:56.722313 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-22 02:42:56.774399 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:42:56.781339 | 2025-02-22 02:42:56.781444 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-22 02:42:56.875736 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:42:56.908469 | 2025-02-22 02:42:56.908617 | TASK [emit-job-header : Print job information] 2025-02-22 02:42:57.011905 | # Job Information 2025-02-22 02:42:57.012062 | Ansible Version: 2.15.3 2025-02-22 02:42:57.012093 | Job: ansible-collection-ensure-readme 2025-02-22 02:42:57.012123 | Pipeline: check 2025-02-22 02:42:57.012144 | Executor: 7d211f194f6a 2025-02-22 02:42:57.012162 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1631 2025-02-22 02:42:57.012180 | Event ID: ab25d970-f0c6-11ef-874d-9dc947509dd9 2025-02-22 02:42:57.018231 | 2025-02-22 02:42:57.018323 | LOOP [emit-job-header : Print node information] 2025-02-22 02:42:57.376177 | ubuntu-noble | ok: 2025-02-22 02:42:57.378832 | ubuntu-noble | # Node Information 2025-02-22 02:42:57.378915 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-22 02:42:57.378943 | ubuntu-noble | Hostname: ubuntu 2025-02-22 02:42:57.378966 | ubuntu-noble | Username: zuul 2025-02-22 02:42:57.378987 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-22 02:42:57.379006 | ubuntu-noble | Provider: regiocloud-a 2025-02-22 02:42:57.379026 | ubuntu-noble | Label: ubuntu-noble 2025-02-22 02:42:57.379045 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-22 02:42:57.379065 | ubuntu-noble | Interface IP: 81.163.192.105 2025-02-22 02:42:57.410185 | 2025-02-22 02:42:57.410305 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-22 02:42:58.443777 | ubuntu-noble -> localhost | changed 2025-02-22 02:42:58.450445 | 2025-02-22 02:42:58.450530 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-22 02:43:00.291958 | ubuntu-noble -> localhost | changed 2025-02-22 02:43:00.309690 | 2025-02-22 02:43:00.309785 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-22 02:43:00.784185 | ubuntu-noble -> localhost | ok 2025-02-22 02:43:00.790862 | 2025-02-22 02:43:00.791183 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-22 02:43:00.830781 | ubuntu-noble | ok 2025-02-22 02:43:00.858106 | ubuntu-noble | included: /var/lib/zuul/builds/117e43a1f2694cada33230bece34aece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-22 02:43:00.868174 | 2025-02-22 02:43:00.868268 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-22 02:43:02.235177 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-22 02:43:02.235371 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/117e43a1f2694cada33230bece34aece/work/117e43a1f2694cada33230bece34aece_id_rsa 2025-02-22 02:43:02.235405 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/117e43a1f2694cada33230bece34aece/work/117e43a1f2694cada33230bece34aece_id_rsa.pub 2025-02-22 02:43:02.235427 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-22 02:43:02.235448 | ubuntu-noble -> localhost | SHA256:/m3A9/FvSTiXzaTn1WSoNlJ5YeRJAWKYLz5JYzYgHag zuul-build-sshkey 2025-02-22 02:43:02.235466 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-22 02:43:02.235488 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-22 02:43:02.235506 | ubuntu-noble -> localhost | | o.. oo .o+. | 2025-02-22 02:43:02.235523 | ubuntu-noble -> localhost | | o o o. . oo. | 2025-02-22 02:43:02.235540 | ubuntu-noble -> localhost | | . . . . ooo | 2025-02-22 02:43:02.235556 | ubuntu-noble -> localhost | | E B . o o +| 2025-02-22 02:43:02.235572 | ubuntu-noble -> localhost | | =S* . o.*+| 2025-02-22 02:43:02.235588 | ubuntu-noble -> localhost | | .+ + =oo+*| 2025-02-22 02:43:02.235605 | ubuntu-noble -> localhost | | .. = o+=o| 2025-02-22 02:43:02.235622 | ubuntu-noble -> localhost | | . .. ..+| 2025-02-22 02:43:02.235639 | ubuntu-noble -> localhost | | ... .o| 2025-02-22 02:43:02.235656 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-22 02:43:02.235699 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.495595 2025-02-22 02:43:02.241944 | 2025-02-22 02:43:02.242036 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-22 02:43:02.294520 | ubuntu-noble | ok 2025-02-22 02:43:02.311730 | ubuntu-noble | included: /var/lib/zuul/builds/117e43a1f2694cada33230bece34aece/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-22 02:43:02.319550 | 2025-02-22 02:43:02.319639 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-22 02:43:02.384085 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:43:02.390930 | 2025-02-22 02:43:02.391021 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-22 02:43:03.294144 | ubuntu-noble | changed 2025-02-22 02:43:03.309745 | 2025-02-22 02:43:03.309857 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-22 02:43:03.693160 | ubuntu-noble | ok 2025-02-22 02:43:03.711510 | 2025-02-22 02:43:03.711626 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-22 02:43:04.519827 | ubuntu-noble | changed 2025-02-22 02:43:04.526321 | 2025-02-22 02:43:04.526409 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-22 02:43:05.352910 | ubuntu-noble | changed 2025-02-22 02:43:05.375166 | 2025-02-22 02:43:05.375263 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-22 02:43:05.434072 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:43:05.441030 | 2025-02-22 02:43:05.441123 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-22 02:43:07.106771 | ubuntu-noble -> localhost | changed 2025-02-22 02:43:07.120754 | 2025-02-22 02:43:07.137293 | TASK [add-build-sshkey : Add back temp key] 2025-02-22 02:43:07.472914 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/117e43a1f2694cada33230bece34aece/work/117e43a1f2694cada33230bece34aece_id_rsa (zuul-build-sshkey) 2025-02-22 02:43:07.473144 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.012456 2025-02-22 02:43:07.481217 | 2025-02-22 02:43:07.481315 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-22 02:43:07.897717 | ubuntu-noble | ok 2025-02-22 02:43:07.902922 | 2025-02-22 02:43:07.903001 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-22 02:43:07.944606 | ubuntu-noble | skipping: Conditional result was False 2025-02-22 02:43:07.958242 | 2025-02-22 02:43:07.958334 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-22 02:43:08.454726 | ubuntu-noble | ok 2025-02-22 02:43:08.486671 | 2025-02-22 02:43:08.486784 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-22 02:43:08.557755 | ubuntu-noble | ok 2025-02-22 02:43:08.564340 | 2025-02-22 02:43:08.564453 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-22 02:43:09.406304 | ubuntu-noble -> localhost | ok 2025-02-22 02:43:09.414177 | 2025-02-22 02:43:09.414268 | TASK [validate-host : Collect information about the host] 2025-02-22 02:43:10.700277 | ubuntu-noble | ok 2025-02-22 02:43:10.742576 | 2025-02-22 02:43:10.742695 | TASK [validate-host : Sanitize hostname] 2025-02-22 02:43:10.863545 | ubuntu-noble | ok 2025-02-22 02:43:10.870996 | 2025-02-22 02:43:10.871098 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-22 02:43:12.120121 | ubuntu-noble -> localhost | changed 2025-02-22 02:43:12.132243 | 2025-02-22 02:43:12.132345 | TASK [validate-host : Collect information about zuul worker] 2025-02-22 02:43:13.053325 | ubuntu-noble | ok 2025-02-22 02:43:13.058667 | 2025-02-22 02:43:13.063810 | TASK [validate-host : Write out all zuul information for each host] 2025-02-22 02:43:14.743044 | ubuntu-noble -> localhost | changed 2025-02-22 02:43:14.759888 | 2025-02-22 02:43:14.759977 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-22 02:43:15.155482 | ubuntu-noble | ok 2025-02-22 02:43:15.161024 | 2025-02-22 02:43:15.161108 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-22 02:43:17.218160 | ubuntu-noble | changed: 2025-02-22 02:43:17.218306 | ubuntu-noble | cd+++++++++ src/ 2025-02-22 02:43:17.218332 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-22 02:43:17.218351 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-22 02:43:17.218367 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-22 02:43:17.218386 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.013745 2025-02-22 02:43:38.744935 | 2025-02-22 02:43:38.745047 | TASK [upload-logs : Upload logs to log server] 2025-02-22 02:43:39.374337 | localhost | Output suppressed because no_log was given 2025-02-22 02:43:39.377621 | 2025-02-22 02:43:39.377726 | LOOP [upload-logs : Compress console log and json output] 2025-02-22 02:43:39.450366 | localhost | skipping: Conditional result was False 2025-02-22 02:43:39.470167 | localhost | skipping: Conditional result was False 2025-02-22 02:43:39.481845 | 2025-02-22 02:43:39.482059 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-22 02:43:39.552682 | localhost | skipping: Conditional result was False 2025-02-22 02:43:39.553021 | 2025-02-22 02:43:39.589235 | localhost | skipping: Conditional result was False 2025-02-22 02:43:39.598457 | 2025-02-22 02:43:39.598580 | LOOP [upload-logs : Upload console log and json output]