2025-02-14 03:42:55.693962 | Job console starting... 2025-02-14 03:42:55.705923 | Updating repositories 2025-02-14 03:42:56.023313 | Preparing job workspace 2025-02-14 03:42:58.844083 | Running Ansible setup... 2025-02-14 03:43:06.126462 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-14 03:43:06.874444 | 2025-02-14 03:43:06.874575 | PLAY [Base pre] 2025-02-14 03:43:06.938269 | 2025-02-14 03:43:06.938400 | TASK [Setup log path fact] 2025-02-14 03:43:06.999673 | ubuntu-noble | ok 2025-02-14 03:43:07.057802 | 2025-02-14 03:43:07.057933 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-14 03:43:07.131646 | ubuntu-noble | ok 2025-02-14 03:43:07.139015 | 2025-02-14 03:43:07.139111 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-14 03:43:07.193508 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:07.200883 | 2025-02-14 03:43:07.200993 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-14 03:43:07.384578 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:07.391538 | 2025-02-14 03:43:07.391638 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-14 03:43:07.468055 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:07.475084 | 2025-02-14 03:43:07.475183 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-14 03:43:07.509900 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:07.518421 | 2025-02-14 03:43:07.518521 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-14 03:43:07.598085 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:07.623572 | 2025-02-14 03:43:07.623683 | TASK [emit-job-header : Print job information] 2025-02-14 03:43:07.726220 | # Job Information 2025-02-14 03:43:07.726374 | Ansible Version: 2.15.3 2025-02-14 03:43:07.726405 | Job: python-black 2025-02-14 03:43:07.726434 | Pipeline: check 2025-02-14 03:43:07.726455 | Executor: 7d211f194f6a 2025-02-14 03:43:07.726474 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1759 2025-02-14 03:43:07.726494 | Event ID: c1463b10-ea85-11ef-8a36-762a93788b10 2025-02-14 03:43:07.736998 | 2025-02-14 03:43:07.737101 | LOOP [emit-job-header : Print node information] 2025-02-14 03:43:07.963073 | ubuntu-noble | ok: 2025-02-14 03:43:07.963235 | ubuntu-noble | # Node Information 2025-02-14 03:43:07.963268 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-14 03:43:07.963291 | ubuntu-noble | Hostname: ubuntu 2025-02-14 03:43:07.963312 | ubuntu-noble | Username: zuul 2025-02-14 03:43:07.963332 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-14 03:43:07.963351 | ubuntu-noble | Provider: regiocloud-a 2025-02-14 03:43:07.963378 | ubuntu-noble | Label: ubuntu-noble 2025-02-14 03:43:07.963399 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-14 03:43:07.963419 | ubuntu-noble | Interface IP: 81.163.192.216 2025-02-14 03:43:07.991231 | 2025-02-14 03:43:07.992536 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-14 03:43:08.933083 | ubuntu-noble -> localhost | changed 2025-02-14 03:43:08.943116 | 2025-02-14 03:43:08.943205 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-14 03:43:10.626035 | ubuntu-noble -> localhost | changed 2025-02-14 03:43:10.640790 | 2025-02-14 03:43:10.640903 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-14 03:43:11.317365 | ubuntu-noble -> localhost | ok 2025-02-14 03:43:11.324848 | 2025-02-14 03:43:11.324944 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-14 03:43:11.382898 | ubuntu-noble | ok 2025-02-14 03:43:11.448024 | ubuntu-noble | included: /var/lib/zuul/builds/4e00af37f396493aaf78f17139629868/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-14 03:43:11.455719 | 2025-02-14 03:43:11.455829 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-14 03:43:12.795418 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-14 03:43:12.795611 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4e00af37f396493aaf78f17139629868/work/4e00af37f396493aaf78f17139629868_id_rsa 2025-02-14 03:43:12.795644 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4e00af37f396493aaf78f17139629868/work/4e00af37f396493aaf78f17139629868_id_rsa.pub 2025-02-14 03:43:12.795663 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-14 03:43:12.795681 | ubuntu-noble -> localhost | SHA256:+p1ezSwjTYdA10ZKoNzwhoJgCjlFdqegYdClPct8V8g zuul-build-sshkey 2025-02-14 03:43:12.795698 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-14 03:43:12.795718 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-14 03:43:12.795734 | ubuntu-noble -> localhost | |=*B.o . . o.oo. | 2025-02-14 03:43:12.795750 | ubuntu-noble -> localhost | |=*.* + o O o .o | 2025-02-14 03:43:12.795765 | ubuntu-noble -> localhost | |o.. = . E * .. | 2025-02-14 03:43:12.795792 | ubuntu-noble -> localhost | | o o . o . . | 2025-02-14 03:43:12.795809 | ubuntu-noble -> localhost | | + . S o . | 2025-02-14 03:43:12.795824 | ubuntu-noble -> localhost | | . o o = | 2025-02-14 03:43:12.795840 | ubuntu-noble -> localhost | | . . = + | 2025-02-14 03:43:12.795856 | ubuntu-noble -> localhost | | . . + o | 2025-02-14 03:43:12.795871 | ubuntu-noble -> localhost | | ..+ | 2025-02-14 03:43:12.795886 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-14 03:43:12.795931 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.446832 2025-02-14 03:43:12.812404 | 2025-02-14 03:43:12.812490 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-14 03:43:12.877382 | ubuntu-noble | ok 2025-02-14 03:43:12.902503 | ubuntu-noble | included: /var/lib/zuul/builds/4e00af37f396493aaf78f17139629868/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-14 03:43:12.910368 | 2025-02-14 03:43:12.910447 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-14 03:43:12.975123 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:12.981566 | 2025-02-14 03:43:12.981657 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-14 03:43:13.875219 | ubuntu-noble | changed 2025-02-14 03:43:13.880845 | 2025-02-14 03:43:13.880925 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-14 03:43:14.220954 | ubuntu-noble | ok 2025-02-14 03:43:14.234121 | 2025-02-14 03:43:14.234233 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-14 03:43:15.092242 | ubuntu-noble | changed 2025-02-14 03:43:15.101913 | 2025-02-14 03:43:15.102009 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-14 03:43:16.031516 | ubuntu-noble | changed 2025-02-14 03:43:16.037885 | 2025-02-14 03:43:16.037973 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-14 03:43:16.113319 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:16.243395 | 2025-02-14 03:43:16.243492 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-14 03:43:17.167740 | ubuntu-noble -> localhost | changed 2025-02-14 03:43:17.190950 | 2025-02-14 03:43:17.191063 | TASK [add-build-sshkey : Add back temp key] 2025-02-14 03:43:17.984746 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4e00af37f396493aaf78f17139629868/work/4e00af37f396493aaf78f17139629868_id_rsa (zuul-build-sshkey) 2025-02-14 03:43:17.984987 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.038750 2025-02-14 03:43:17.992448 | 2025-02-14 03:43:17.992535 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-14 03:43:18.607610 | ubuntu-noble | ok 2025-02-14 03:43:18.622149 | 2025-02-14 03:43:18.622250 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-14 03:43:18.686379 | ubuntu-noble | skipping: Conditional result was False 2025-02-14 03:43:18.703895 | 2025-02-14 03:43:18.703994 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-14 03:43:19.231836 | ubuntu-noble | ok 2025-02-14 03:43:19.248909 | 2025-02-14 03:43:19.249005 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-14 03:43:19.287754 | ubuntu-noble | ok 2025-02-14 03:43:19.296909 | 2025-02-14 03:43:19.296999 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-14 03:43:19.908841 | ubuntu-noble -> localhost | ok 2025-02-14 03:43:19.915432 | 2025-02-14 03:43:19.915540 | TASK [validate-host : Collect information about the host] 2025-02-14 03:43:21.216760 | ubuntu-noble | ok 2025-02-14 03:43:21.252928 | 2025-02-14 03:43:21.253032 | TASK [validate-host : Sanitize hostname] 2025-02-14 03:43:21.510538 | ubuntu-noble | ok 2025-02-14 03:43:21.519504 | 2025-02-14 03:43:21.519599 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-14 03:43:22.780136 | ubuntu-noble -> localhost | changed 2025-02-14 03:43:22.785698 | 2025-02-14 03:43:22.785778 | TASK [validate-host : Collect information about zuul worker] 2025-02-14 03:43:23.417718 | ubuntu-noble | ok 2025-02-14 03:43:23.422543 | 2025-02-14 03:43:23.422624 | TASK [validate-host : Write out all zuul information for each host] 2025-02-14 03:43:24.425159 | ubuntu-noble -> localhost | changed 2025-02-14 03:43:24.435141 | 2025-02-14 03:43:24.435234 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-14 03:43:24.802175 | ubuntu-noble | ok 2025-02-14 03:43:24.807588 | 2025-02-14 03:43:24.807668 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-14 03:43:26.445805 | ubuntu-noble | changed: 2025-02-14 03:43:26.445950 | ubuntu-noble | cd+++++++++ src/ 2025-02-14 03:43:26.445976 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-14 03:43:26.445996 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-14 03:43:26.446013 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-14 03:43:26.446030 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007673 2025-02-14 03:44:03.563672 | 2025-02-14 03:44:03.563859 | TASK [upload-logs : Upload logs to log server] 2025-02-14 03:44:04.188277 | localhost | Output suppressed because no_log was given 2025-02-14 03:44:04.192842 | 2025-02-14 03:44:04.192965 | LOOP [upload-logs : Compress console log and json output] 2025-02-14 03:44:04.279527 | localhost | skipping: Conditional result was False 2025-02-14 03:44:04.299554 | localhost | skipping: Conditional result was False 2025-02-14 03:44:04.307138 | 2025-02-14 03:44:04.307301 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-14 03:44:04.415456 | localhost | skipping: Conditional result was False 2025-02-14 03:44:04.415906 | 2025-02-14 03:44:04.433614 | localhost | skipping: Conditional result was False 2025-02-14 03:44:04.445095 | 2025-02-14 03:44:04.445296 | LOOP [upload-logs : Upload console log and json output]