2025-02-05 19:48:52.684063 | Job console starting... 2025-02-05 19:48:52.729275 | Updating repositories 2025-02-05 19:48:52.803486 | Preparing job workspace 2025-02-05 19:48:55.248753 | Running Ansible setup... 2025-02-05 19:49:00.997303 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-05 19:49:02.058010 | 2025-02-05 19:49:02.058192 | PLAY [Base pre] 2025-02-05 19:49:02.108055 | 2025-02-05 19:49:02.108235 | TASK [Setup log path fact] 2025-02-05 19:49:02.156596 | ubuntu-noble | ok 2025-02-05 19:49:02.191200 | 2025-02-05 19:49:02.191381 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 19:49:02.263929 | ubuntu-noble | ok 2025-02-05 19:49:02.283163 | 2025-02-05 19:49:02.283312 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 19:49:02.319279 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:02.326754 | 2025-02-05 19:49:02.326887 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 19:49:02.446896 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:02.454606 | 2025-02-05 19:49:02.454742 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-05 19:49:02.512856 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:02.520512 | 2025-02-05 19:49:02.520674 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-05 19:49:02.578028 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:02.587327 | 2025-02-05 19:49:02.587491 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-05 19:49:02.627850 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:02.648981 | 2025-02-05 19:49:02.649137 | TASK [emit-job-header : Print job information] 2025-02-05 19:49:02.726828 | # Job Information 2025-02-05 19:49:02.727079 | Ansible Version: 2.15.3 2025-02-05 19:49:02.727118 | Job: python-black 2025-02-05 19:49:02.727148 | Pipeline: check 2025-02-05 19:49:02.727169 | Executor: 7d211f194f6a 2025-02-05 19:49:02.727188 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1754 2025-02-05 19:49:02.727206 | Event ID: 351ac250-e3fa-11ef-9aa4-46fd0f669107 2025-02-05 19:49:02.744058 | 2025-02-05 19:49:02.744218 | LOOP [emit-job-header : Print node information] 2025-02-05 19:49:02.939032 | ubuntu-noble | ok: 2025-02-05 19:49:02.939234 | ubuntu-noble | # Node Information 2025-02-05 19:49:02.939268 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-05 19:49:02.939292 | ubuntu-noble | Hostname: ubuntu 2025-02-05 19:49:02.939314 | ubuntu-noble | Username: zuul 2025-02-05 19:49:02.939333 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-05 19:49:02.939353 | ubuntu-noble | Provider: regiocloud-a 2025-02-05 19:49:02.939371 | ubuntu-noble | Label: ubuntu-noble 2025-02-05 19:49:02.939390 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-05 19:49:02.939410 | ubuntu-noble | Interface IP: 81.163.192.83 2025-02-05 19:49:02.979719 | 2025-02-05 19:49:02.979927 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-05 19:49:03.723358 | ubuntu-noble -> localhost | changed 2025-02-05 19:49:03.734427 | 2025-02-05 19:49:03.734568 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-05 19:49:05.048469 | ubuntu-noble -> localhost | changed 2025-02-05 19:49:05.070931 | 2025-02-05 19:49:05.071052 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-05 19:49:05.495651 | ubuntu-noble -> localhost | ok 2025-02-05 19:49:05.502873 | 2025-02-05 19:49:05.502983 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-05 19:49:05.562326 | ubuntu-noble | ok 2025-02-05 19:49:05.595179 | ubuntu-noble | included: /var/lib/zuul/builds/1c6ba8e04b754f5582f4818621e9a925/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-05 19:49:05.607839 | 2025-02-05 19:49:05.607964 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-05 19:49:06.384148 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-05 19:49:06.384310 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/1c6ba8e04b754f5582f4818621e9a925/work/1c6ba8e04b754f5582f4818621e9a925_id_rsa 2025-02-05 19:49:06.384339 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/1c6ba8e04b754f5582f4818621e9a925/work/1c6ba8e04b754f5582f4818621e9a925_id_rsa.pub 2025-02-05 19:49:06.384359 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-05 19:49:06.384378 | ubuntu-noble -> localhost | SHA256:D15QbFLMnRM/AcJgtcJm0cqZfCVJv8TPj1LlzbWpoy8 zuul-build-sshkey 2025-02-05 19:49:06.384410 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-05 19:49:06.384431 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-05 19:49:06.384448 | ubuntu-noble -> localhost | | +@*oo+. | 2025-02-05 19:49:06.384464 | ubuntu-noble -> localhost | | o.oX==. . | 2025-02-05 19:49:06.384481 | ubuntu-noble -> localhost | | o**.o+.o o| 2025-02-05 19:49:06.384497 | ubuntu-noble -> localhost | | o*o.. + ==| 2025-02-05 19:49:06.384513 | ubuntu-noble -> localhost | | S.. . +o+| 2025-02-05 19:49:06.384529 | ubuntu-noble -> localhost | | . + ..o | 2025-02-05 19:49:06.384545 | ubuntu-noble -> localhost | | . . .o. .| 2025-02-05 19:49:06.384561 | ubuntu-noble -> localhost | | E... | 2025-02-05 19:49:06.384578 | ubuntu-noble -> localhost | | .o. | 2025-02-05 19:49:06.384593 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-05 19:49:06.384631 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.165638 2025-02-05 19:49:06.391349 | 2025-02-05 19:49:06.391437 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-05 19:49:06.431129 | ubuntu-noble | ok 2025-02-05 19:49:06.453799 | ubuntu-noble | included: /var/lib/zuul/builds/1c6ba8e04b754f5582f4818621e9a925/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-05 19:49:06.470785 | 2025-02-05 19:49:06.470891 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-05 19:49:06.496276 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:06.503445 | 2025-02-05 19:49:06.503543 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-05 19:49:07.167584 | ubuntu-noble | changed 2025-02-05 19:49:07.174308 | 2025-02-05 19:49:07.174397 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-05 19:49:07.516892 | ubuntu-noble | ok 2025-02-05 19:49:07.537722 | 2025-02-05 19:49:07.537850 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-05 19:49:08.230504 | ubuntu-noble | changed 2025-02-05 19:49:08.237372 | 2025-02-05 19:49:08.237465 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-05 19:49:08.939067 | ubuntu-noble | changed 2025-02-05 19:49:08.947690 | 2025-02-05 19:49:08.947788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-05 19:49:08.971778 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:08.980362 | 2025-02-05 19:49:08.980685 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-05 19:49:09.358707 | ubuntu-noble -> localhost | changed 2025-02-05 19:49:09.369990 | 2025-02-05 19:49:09.370090 | TASK [add-build-sshkey : Add back temp key] 2025-02-05 19:49:09.844237 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/1c6ba8e04b754f5582f4818621e9a925/work/1c6ba8e04b754f5582f4818621e9a925_id_rsa (zuul-build-sshkey) 2025-02-05 19:49:09.844498 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014382 2025-02-05 19:49:09.901945 | 2025-02-05 19:49:09.902051 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-05 19:49:10.524020 | ubuntu-noble | ok 2025-02-05 19:49:10.546698 | 2025-02-05 19:49:10.548538 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-05 19:49:10.615375 | ubuntu-noble | skipping: Conditional result was False 2025-02-05 19:49:10.628194 | 2025-02-05 19:49:10.628304 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-05 19:49:11.153814 | ubuntu-noble | ok 2025-02-05 19:49:11.180634 | 2025-02-05 19:49:11.180758 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-05 19:49:11.251408 | ubuntu-noble | ok 2025-02-05 19:49:11.257773 | 2025-02-05 19:49:11.257873 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-05 19:49:11.816328 | ubuntu-noble -> localhost | ok 2025-02-05 19:49:11.823736 | 2025-02-05 19:49:11.823831 | TASK [validate-host : Collect information about the host] 2025-02-05 19:49:12.967090 | ubuntu-noble | ok 2025-02-05 19:49:12.998114 | 2025-02-05 19:49:12.998271 | TASK [validate-host : Sanitize hostname] 2025-02-05 19:49:13.100319 | ubuntu-noble | ok 2025-02-05 19:49:13.107159 | 2025-02-05 19:49:13.107273 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-05 19:49:13.787766 | ubuntu-noble -> localhost | changed 2025-02-05 19:49:13.796613 | 2025-02-05 19:49:13.796740 | TASK [validate-host : Collect information about zuul worker] 2025-02-05 19:49:14.284280 | ubuntu-noble | ok 2025-02-05 19:49:14.290779 | 2025-02-05 19:49:14.290908 | TASK [validate-host : Write out all zuul information for each host] 2025-02-05 19:49:15.205300 | ubuntu-noble -> localhost | changed 2025-02-05 19:49:15.221097 | 2025-02-05 19:49:15.221247 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-05 19:49:15.557722 | ubuntu-noble | ok 2025-02-05 19:49:15.565464 | 2025-02-05 19:49:15.565592 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-05 19:49:17.010162 | ubuntu-noble | changed: 2025-02-05 19:49:17.010392 | ubuntu-noble | cd+++++++++ src/ 2025-02-05 19:49:17.010426 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-05 19:49:17.010449 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-05 19:49:17.010470 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-05 19:49:17.010490 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.008160 2025-02-05 19:49:51.950278 | 2025-02-05 19:49:51.950397 | TASK [upload-logs : Upload logs to log server] 2025-02-05 19:49:52.566683 | localhost | Output suppressed because no_log was given 2025-02-05 19:49:52.569823 | 2025-02-05 19:49:52.569981 | LOOP [upload-logs : Compress console log and json output] 2025-02-05 19:49:52.640876 | localhost | skipping: Conditional result was False 2025-02-05 19:49:52.658518 | localhost | skipping: Conditional result was False 2025-02-05 19:49:52.676319 | 2025-02-05 19:49:52.676557 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-05 19:49:52.743996 | localhost | skipping: Conditional result was False 2025-02-05 19:49:52.744756 | 2025-02-05 19:49:52.769852 | localhost | skipping: Conditional result was False 2025-02-05 19:49:52.785734 | 2025-02-05 19:49:52.785950 | LOOP [upload-logs : Upload console log and json output]