2025-02-25 22:03:58.050100 | Job console starting... 2025-02-25 22:03:58.057556 | Updating repositories 2025-02-25 22:03:58.095412 | Preparing job workspace 2025-02-25 22:03:59.532920 | Running Ansible setup... 2025-02-25 22:04:04.547090 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 22:04:05.333302 | 2025-02-25 22:04:05.333468 | PLAY [Base pre] 2025-02-25 22:04:05.363351 | 2025-02-25 22:04:05.363484 | TASK [Setup log path fact] 2025-02-25 22:04:05.396140 | ubuntu-noble | ok 2025-02-25 22:04:05.418782 | 2025-02-25 22:04:05.418911 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 22:04:05.476436 | ubuntu-noble | ok 2025-02-25 22:04:05.485286 | 2025-02-25 22:04:05.485408 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 22:04:05.521047 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:05.534010 | 2025-02-25 22:04:05.534173 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 22:04:05.580465 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:05.595712 | 2025-02-25 22:04:05.595878 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 22:04:05.622541 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:05.636787 | 2025-02-25 22:04:05.636954 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 22:04:05.663454 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:05.680683 | 2025-02-25 22:04:05.680924 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 22:04:05.717310 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:05.743966 | 2025-02-25 22:04:05.744111 | TASK [emit-job-header : Print job information] 2025-02-25 22:04:05.818413 | # Job Information 2025-02-25 22:04:05.818725 | Ansible Version: 2.15.3 2025-02-25 22:04:05.818784 | Job: python-black 2025-02-25 22:04:05.818836 | Pipeline: check 2025-02-25 22:04:05.818874 | Executor: 7d211f194f6a 2025-02-25 22:04:05.818907 | Triggered by: https://github.com/osism/ansible-collection-validations/pull/212 2025-02-25 22:04:05.818940 | Event ID: 85c46e30-f3c3-11ef-9d7f-8c54732f8656 2025-02-25 22:04:05.827837 | 2025-02-25 22:04:05.827960 | LOOP [emit-job-header : Print node information] 2025-02-25 22:04:06.004933 | ubuntu-noble | ok: 2025-02-25 22:04:06.005207 | ubuntu-noble | # Node Information 2025-02-25 22:04:06.005259 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 22:04:06.005297 | ubuntu-noble | Hostname: ubuntu 2025-02-25 22:04:06.005332 | ubuntu-noble | Username: zuul 2025-02-25 22:04:06.005364 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 22:04:06.005395 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 22:04:06.005426 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 22:04:06.005457 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 22:04:06.005489 | ubuntu-noble | Interface IP: 81.163.193.215 2025-02-25 22:04:06.035098 | 2025-02-25 22:04:06.035224 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 22:04:06.527153 | ubuntu-noble -> localhost | changed 2025-02-25 22:04:06.543844 | 2025-02-25 22:04:06.544004 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 22:04:07.601045 | ubuntu-noble -> localhost | changed 2025-02-25 22:04:07.615191 | 2025-02-25 22:04:07.615308 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 22:04:07.894240 | ubuntu-noble -> localhost | ok 2025-02-25 22:04:07.902817 | 2025-02-25 22:04:07.902929 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 22:04:07.946751 | ubuntu-noble | ok 2025-02-25 22:04:07.963417 | ubuntu-noble | included: /var/lib/zuul/builds/925c9c746c9c4827830bdc865f1e0167/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 22:04:07.971123 | 2025-02-25 22:04:07.971222 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 22:04:08.680928 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 22:04:08.681289 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/925c9c746c9c4827830bdc865f1e0167/work/925c9c746c9c4827830bdc865f1e0167_id_rsa 2025-02-25 22:04:08.681350 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/925c9c746c9c4827830bdc865f1e0167/work/925c9c746c9c4827830bdc865f1e0167_id_rsa.pub 2025-02-25 22:04:08.681389 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 22:04:08.681423 | ubuntu-noble -> localhost | SHA256:tKj8NrWody+3HZZq11PouM8pm5OGp3kwsTsqKdys3LY zuul-build-sshkey 2025-02-25 22:04:08.681457 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 22:04:08.681495 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 22:04:08.681575 | ubuntu-noble -> localhost | | | 2025-02-25 22:04:08.681609 | ubuntu-noble -> localhost | | | 2025-02-25 22:04:08.681638 | ubuntu-noble -> localhost | | . | 2025-02-25 22:04:08.681668 | ubuntu-noble -> localhost | | o .. | 2025-02-25 22:04:08.681698 | ubuntu-noble -> localhost | | . S o . | 2025-02-25 22:04:08.681726 | ubuntu-noble -> localhost | | . . . + .. .| 2025-02-25 22:04:08.681756 | ubuntu-noble -> localhost | | .oo + . =+= . | 2025-02-25 22:04:08.681786 | ubuntu-noble -> localhost | | .oo@ + *=X++. | 2025-02-25 22:04:08.681816 | ubuntu-noble -> localhost | | +BE=.**O=*+. | 2025-02-25 22:04:08.681845 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 22:04:08.681920 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.209611 2025-02-25 22:04:08.692728 | 2025-02-25 22:04:08.692844 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 22:04:08.727269 | ubuntu-noble | ok 2025-02-25 22:04:08.739378 | ubuntu-noble | included: /var/lib/zuul/builds/925c9c746c9c4827830bdc865f1e0167/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 22:04:08.749346 | 2025-02-25 22:04:08.749445 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 22:04:08.784304 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:08.793609 | 2025-02-25 22:04:08.793730 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 22:04:09.525459 | ubuntu-noble | changed 2025-02-25 22:04:09.535716 | 2025-02-25 22:04:09.535844 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 22:04:09.823255 | ubuntu-noble | ok 2025-02-25 22:04:09.830782 | 2025-02-25 22:04:09.830893 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 22:04:10.547031 | ubuntu-noble | changed 2025-02-25 22:04:10.559841 | 2025-02-25 22:04:10.560032 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 22:04:11.264963 | ubuntu-noble | changed 2025-02-25 22:04:11.275611 | 2025-02-25 22:04:11.275751 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 22:04:11.312677 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:11.328770 | 2025-02-25 22:04:11.328926 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 22:04:11.772911 | ubuntu-noble -> localhost | changed 2025-02-25 22:04:11.799131 | 2025-02-25 22:04:11.799266 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 22:04:12.142659 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/925c9c746c9c4827830bdc865f1e0167/work/925c9c746c9c4827830bdc865f1e0167_id_rsa (zuul-build-sshkey) 2025-02-25 22:04:12.143215 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016811 2025-02-25 22:04:12.160733 | 2025-02-25 22:04:12.160892 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 22:04:12.612626 | ubuntu-noble | ok 2025-02-25 22:04:12.619137 | 2025-02-25 22:04:12.619243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 22:04:12.654701 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 22:04:12.683898 | 2025-02-25 22:04:12.684011 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 22:04:13.088192 | ubuntu-noble | ok 2025-02-25 22:04:13.105762 | 2025-02-25 22:04:13.105877 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 22:04:13.144972 | ubuntu-noble | ok 2025-02-25 22:04:13.151598 | 2025-02-25 22:04:13.151702 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 22:04:13.476567 | ubuntu-noble -> localhost | ok 2025-02-25 22:04:13.492840 | 2025-02-25 22:04:13.493006 | TASK [validate-host : Collect information about the host] 2025-02-25 22:04:14.612462 | ubuntu-noble | ok 2025-02-25 22:04:14.627565 | 2025-02-25 22:04:14.627687 | TASK [validate-host : Sanitize hostname] 2025-02-25 22:04:14.700991 | ubuntu-noble | ok 2025-02-25 22:04:14.707777 | 2025-02-25 22:04:14.707900 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 22:04:15.305740 | ubuntu-noble -> localhost | changed 2025-02-25 22:04:15.313383 | 2025-02-25 22:04:15.313545 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 22:04:15.798432 | ubuntu-noble | ok 2025-02-25 22:04:15.805940 | 2025-02-25 22:04:15.806057 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 22:04:16.413208 | ubuntu-noble -> localhost | changed 2025-02-25 22:04:16.425684 | 2025-02-25 22:04:16.425800 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 22:04:16.752675 | ubuntu-noble | ok 2025-02-25 22:04:16.764169 | 2025-02-25 22:04:16.764302 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 22:04:17.623738 | ubuntu-noble | changed: 2025-02-25 22:04:17.624054 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 22:04:17.624092 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 22:04:17.624118 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 22:04:17.624139 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-validations/ 2025-02-25 22:04:17.624160 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008696 2025-02-25 22:04:49.045455 | 2025-02-25 22:04:49.045613 | TASK [upload-logs : Upload logs to log server] 2025-02-25 22:04:49.643860 | localhost | Output suppressed because no_log was given 2025-02-25 22:04:49.650226 | 2025-02-25 22:04:49.650389 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 22:04:49.717780 | localhost | skipping: Conditional result was False 2025-02-25 22:04:49.735418 | localhost | skipping: Conditional result was False 2025-02-25 22:04:49.754287 | 2025-02-25 22:04:49.754498 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 22:04:49.821299 | localhost | skipping: Conditional result was False 2025-02-25 22:04:49.821615 | 2025-02-25 22:04:49.834462 | localhost | skipping: Conditional result was False 2025-02-25 22:04:49.853357 | 2025-02-25 22:04:49.853575 | LOOP [upload-logs : Upload console log and json output]