2025-03-25 21:41:03.400979 | Job console starting... 2025-03-25 21:41:03.415302 | Updating repositories 2025-03-25 21:41:03.456256 | Preparing job workspace 2025-03-25 21:41:04.963184 | Running Ansible setup... 2025-03-25 21:41:10.049660 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-25 21:41:10.781341 | 2025-03-25 21:41:10.781506 | PLAY [Base pre] 2025-03-25 21:41:10.810855 | 2025-03-25 21:41:10.810977 | TASK [Setup log path fact] 2025-03-25 21:41:10.842926 | ubuntu-noble | ok 2025-03-25 21:41:10.861442 | 2025-03-25 21:41:10.861602 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-25 21:41:10.903603 | ubuntu-noble | ok 2025-03-25 21:41:10.922650 | 2025-03-25 21:41:10.922782 | TASK [emit-job-header : Print job information] 2025-03-25 21:41:10.976682 | # Job Information 2025-03-25 21:41:10.976866 | Ansible Version: 2.15.3 2025-03-25 21:41:10.976910 | Job: python-black 2025-03-25 21:41:10.976942 | Pipeline: check 2025-03-25 21:41:10.976963 | Executor: 7d211f194f6a 2025-03-25 21:41:10.976982 | Triggered by: https://github.com/osism/zuul-jobs/pull/154 2025-03-25 21:41:10.977002 | Event ID: ad99b070-09b0-11f0-820d-9c189dfcef46 2025-03-25 21:41:10.983631 | 2025-03-25 21:41:10.983752 | LOOP [emit-job-header : Print node information] 2025-03-25 21:41:11.148085 | ubuntu-noble | ok: 2025-03-25 21:41:11.148355 | ubuntu-noble | # Node Information 2025-03-25 21:41:11.148434 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-25 21:41:11.148475 | ubuntu-noble | Hostname: ubuntu 2025-03-25 21:41:11.148499 | ubuntu-noble | Username: zuul 2025-03-25 21:41:11.148520 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-25 21:41:11.148544 | ubuntu-noble | Provider: regiocloud-a 2025-03-25 21:41:11.148565 | ubuntu-noble | Label: ubuntu-noble 2025-03-25 21:41:11.148586 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-25 21:41:11.148605 | ubuntu-noble | Interface IP: 81.163.193.59 2025-03-25 21:41:11.168526 | 2025-03-25 21:41:11.168669 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-25 21:41:11.626894 | ubuntu-noble -> localhost | changed 2025-03-25 21:41:11.645809 | 2025-03-25 21:41:11.645972 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-25 21:41:12.757074 | ubuntu-noble -> localhost | changed 2025-03-25 21:41:12.776587 | 2025-03-25 21:41:12.776715 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-25 21:41:13.048098 | ubuntu-noble -> localhost | ok 2025-03-25 21:41:13.062525 | 2025-03-25 21:41:13.062697 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-25 21:41:13.098981 | ubuntu-noble | ok 2025-03-25 21:41:13.116507 | ubuntu-noble | included: /var/lib/zuul/builds/97c2bebe6df243f88dfbfb611f81bc3c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-25 21:41:13.124536 | 2025-03-25 21:41:13.124637 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-25 21:41:13.753214 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-25 21:41:13.753473 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/97c2bebe6df243f88dfbfb611f81bc3c/work/97c2bebe6df243f88dfbfb611f81bc3c_id_rsa 2025-03-25 21:41:13.753512 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/97c2bebe6df243f88dfbfb611f81bc3c/work/97c2bebe6df243f88dfbfb611f81bc3c_id_rsa.pub 2025-03-25 21:41:13.753536 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-25 21:41:13.753559 | ubuntu-noble -> localhost | SHA256:x1clalU4oM/1NwiPaCBJuZI588Wrg6l7GuBobYd/VxM zuul-build-sshkey 2025-03-25 21:41:13.753581 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-25 21:41:13.753602 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-25 21:41:13.753622 | ubuntu-noble -> localhost | | .. ..ooo| 2025-03-25 21:41:13.753643 | ubuntu-noble -> localhost | | ... . ooo | 2025-03-25 21:41:13.753662 | ubuntu-noble -> localhost | | ooo. ..o o. | 2025-03-25 21:41:13.753692 | ubuntu-noble -> localhost | | * ..o...E+o.. | 2025-03-25 21:41:13.753712 | ubuntu-noble -> localhost | |. = . Soo.=o .o| 2025-03-25 21:41:13.753732 | ubuntu-noble -> localhost | |+ . .. ... + o| 2025-03-25 21:41:13.753764 | ubuntu-noble -> localhost | |.+ +o.. . . | 2025-03-25 21:41:13.753787 | ubuntu-noble -> localhost | |. o+oo . . | 2025-03-25 21:41:13.753809 | ubuntu-noble -> localhost | | += .o . | 2025-03-25 21:41:13.753829 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-25 21:41:13.753880 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.148195 2025-03-25 21:41:13.766388 | 2025-03-25 21:41:13.766833 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-25 21:41:13.795929 | ubuntu-noble | ok 2025-03-25 21:41:13.807306 | ubuntu-noble | included: /var/lib/zuul/builds/97c2bebe6df243f88dfbfb611f81bc3c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-25 21:41:13.817404 | 2025-03-25 21:41:13.817518 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-25 21:41:13.841717 | ubuntu-noble | skipping: Conditional result was False 2025-03-25 21:41:13.849252 | 2025-03-25 21:41:13.849361 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-25 21:41:14.602239 | ubuntu-noble | changed 2025-03-25 21:41:14.613410 | 2025-03-25 21:41:14.613586 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-25 21:41:14.960793 | ubuntu-noble | ok 2025-03-25 21:41:14.971884 | 2025-03-25 21:41:14.972022 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-25 21:41:15.772644 | ubuntu-noble | changed 2025-03-25 21:41:15.787508 | 2025-03-25 21:41:15.787694 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-25 21:41:16.587947 | ubuntu-noble | changed 2025-03-25 21:41:16.595346 | 2025-03-25 21:41:16.595489 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-25 21:41:16.630902 | ubuntu-noble | skipping: Conditional result was False 2025-03-25 21:41:16.642720 | 2025-03-25 21:41:16.642859 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-25 21:41:17.087392 | ubuntu-noble -> localhost | changed 2025-03-25 21:41:17.101648 | 2025-03-25 21:41:17.101770 | TASK [add-build-sshkey : Add back temp key] 2025-03-25 21:41:17.442177 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/97c2bebe6df243f88dfbfb611f81bc3c/work/97c2bebe6df243f88dfbfb611f81bc3c_id_rsa (zuul-build-sshkey) 2025-03-25 21:41:17.442424 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008611 2025-03-25 21:41:17.451856 | 2025-03-25 21:41:17.451984 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-25 21:41:17.991751 | ubuntu-noble | ok 2025-03-25 21:41:18.001198 | 2025-03-25 21:41:18.001311 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-25 21:41:18.037622 | ubuntu-noble | skipping: Conditional result was False 2025-03-25 21:41:18.058320 | 2025-03-25 21:41:18.058475 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-25 21:41:18.668249 | ubuntu-noble | ok 2025-03-25 21:41:18.680839 | 2025-03-25 21:41:18.680951 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-25 21:41:18.725331 | ubuntu-noble | ok 2025-03-25 21:41:18.735206 | 2025-03-25 21:41:18.735631 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-25 21:41:19.180995 | ubuntu-noble -> localhost | ok 2025-03-25 21:41:19.189744 | 2025-03-25 21:41:19.189862 | TASK [validate-host : Collect information about the host] 2025-03-25 21:41:20.470894 | ubuntu-noble | ok 2025-03-25 21:41:20.493562 | 2025-03-25 21:41:20.493698 | TASK [validate-host : Sanitize hostname] 2025-03-25 21:41:20.565286 | ubuntu-noble | ok 2025-03-25 21:41:20.571815 | 2025-03-25 21:41:20.571933 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-25 21:41:21.222839 | ubuntu-noble -> localhost | changed 2025-03-25 21:41:21.231415 | 2025-03-25 21:41:21.231567 | TASK [validate-host : Collect information about zuul worker] 2025-03-25 21:41:21.827585 | ubuntu-noble | ok 2025-03-25 21:41:21.838874 | 2025-03-25 21:41:21.839004 | TASK [validate-host : Write out all zuul information for each host] 2025-03-25 21:41:22.453385 | ubuntu-noble -> localhost | changed 2025-03-25 21:41:22.475262 | 2025-03-25 21:41:22.475402 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-25 21:41:22.845632 | ubuntu-noble | ok 2025-03-25 21:41:22.853279 | 2025-03-25 21:41:22.853391 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-25 21:41:23.712100 | ubuntu-noble | changed: 2025-03-25 21:41:23.712348 | ubuntu-noble | cd+++++++++ src/ 2025-03-25 21:41:23.712478 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-25 21:41:23.712518 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-25 21:41:23.712549 | ubuntu-noble | cd+++++++++ src/github.com/osism/zuul-jobs/ 2025-03-25 21:41:23.712585 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.009097 2025-03-25 21:42:00.928574 | 2025-03-25 21:42:00.928697 | TASK [upload-logs : Upload logs to log server] 2025-03-25 21:42:01.510881 | localhost | Output suppressed because no_log was given 2025-03-25 21:42:01.516940 | 2025-03-25 21:42:01.517151 | LOOP [upload-logs : Compress console log and json output] 2025-03-25 21:42:01.588546 | localhost | skipping: Conditional result was False 2025-03-25 21:42:01.605531 | localhost | skipping: Conditional result was False 2025-03-25 21:42:01.620843 | 2025-03-25 21:42:01.620960 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-25 21:42:01.696310 | localhost | skipping: Conditional result was False 2025-03-25 21:42:01.696839 | 2025-03-25 21:42:01.711358 | localhost | skipping: Conditional result was False 2025-03-25 21:42:01.730217 | 2025-03-25 21:42:01.730639 | LOOP [upload-logs : Upload console log and json output]