2025-02-25 23:26:06.481937 | Job console starting... 2025-02-25 23:26:06.502170 | Updating repositories 2025-02-25 23:26:06.559905 | Preparing job workspace 2025-02-25 23:26:08.788094 | Running Ansible setup... 2025-02-25 23:26:15.184424 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-25 23:26:15.944743 | 2025-02-25 23:26:15.944868 | PLAY [Base pre] 2025-02-25 23:26:15.972157 | 2025-02-25 23:26:15.972277 | TASK [Setup log path fact] 2025-02-25 23:26:16.007321 | ubuntu-noble | ok 2025-02-25 23:26:16.029345 | 2025-02-25 23:26:16.029463 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:26:16.069313 | ubuntu-noble | ok 2025-02-25 23:26:16.075702 | 2025-02-25 23:26:16.075796 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:26:16.109492 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.116416 | 2025-02-25 23:26:16.116525 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:26:16.170539 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.177896 | 2025-02-25 23:26:16.177994 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-25 23:26:16.202250 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.209101 | 2025-02-25 23:26:16.209192 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-25 23:26:16.232706 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.242248 | 2025-02-25 23:26:16.242352 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-25 23:26:16.266890 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:16.281339 | 2025-02-25 23:26:16.281434 | TASK [emit-job-header : Print job information] 2025-02-25 23:26:16.377076 | # Job Information 2025-02-25 23:26:16.377228 | Ansible Version: 2.15.3 2025-02-25 23:26:16.377259 | Job: python-black 2025-02-25 23:26:16.377288 | Pipeline: check 2025-02-25 23:26:16.377308 | Executor: 7d211f194f6a 2025-02-25 23:26:16.377327 | Triggered by: https://github.com/osism/ansible-collection-services/pull/1769 2025-02-25 23:26:16.377345 | Event ID: c4ddac60-f3ca-11ef-9b50-8b7254e7429b 2025-02-25 23:26:16.383929 | 2025-02-25 23:26:16.384023 | LOOP [emit-job-header : Print node information] 2025-02-25 23:26:16.531129 | ubuntu-noble | ok: 2025-02-25 23:26:16.531314 | ubuntu-noble | # Node Information 2025-02-25 23:26:16.531444 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-25 23:26:16.531476 | ubuntu-noble | Hostname: ubuntu 2025-02-25 23:26:16.531498 | ubuntu-noble | Username: zuul 2025-02-25 23:26:16.531519 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-25 23:26:16.531538 | ubuntu-noble | Provider: regiocloud-a 2025-02-25 23:26:16.531568 | ubuntu-noble | Label: ubuntu-noble 2025-02-25 23:26:16.531589 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-25 23:26:16.531610 | ubuntu-noble | Interface IP: 81.163.193.137 2025-02-25 23:26:16.554195 | 2025-02-25 23:26:16.554304 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-25 23:26:17.096958 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:17.109413 | 2025-02-25 23:26:17.109518 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-25 23:26:18.158036 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:18.170405 | 2025-02-25 23:26:18.170497 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-25 23:26:18.469653 | ubuntu-noble -> localhost | ok 2025-02-25 23:26:18.476382 | 2025-02-25 23:26:18.476507 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-25 23:26:18.529306 | ubuntu-noble | ok 2025-02-25 23:26:18.558699 | ubuntu-noble | included: /var/lib/zuul/builds/e85114c5b8da46239de5f7ac7affc209/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-25 23:26:18.585471 | 2025-02-25 23:26:18.585591 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-25 23:26:19.335686 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-25 23:26:19.335847 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/e85114c5b8da46239de5f7ac7affc209/work/e85114c5b8da46239de5f7ac7affc209_id_rsa 2025-02-25 23:26:19.335876 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/e85114c5b8da46239de5f7ac7affc209/work/e85114c5b8da46239de5f7ac7affc209_id_rsa.pub 2025-02-25 23:26:19.335895 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-25 23:26:19.335914 | ubuntu-noble -> localhost | SHA256:cKzvXSxf4e6mHkfAIEHsR7wIc+l7id6bb4THbo/26Qw zuul-build-sshkey 2025-02-25 23:26:19.335932 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-25 23:26:19.335951 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-25 23:26:19.335968 | ubuntu-noble -> localhost | | o++. | 2025-02-25 23:26:19.335984 | ubuntu-noble -> localhost | | o.+.oo | 2025-02-25 23:26:19.336000 | ubuntu-noble -> localhost | | .*oo .o | 2025-02-25 23:26:19.336016 | ubuntu-noble -> localhost | | ++ o . | 2025-02-25 23:26:19.336031 | ubuntu-noble -> localhost | | . S+ + o | 2025-02-25 23:26:19.336046 | ubuntu-noble -> localhost | | .o +.+o . | 2025-02-25 23:26:19.336062 | ubuntu-noble -> localhost | | ..o.+E + | 2025-02-25 23:26:19.336078 | ubuntu-noble -> localhost | | ....==O.. | 2025-02-25 23:26:19.336093 | ubuntu-noble -> localhost | | . +B*BO | 2025-02-25 23:26:19.336109 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-25 23:26:19.336147 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.130539 2025-02-25 23:26:19.342454 | 2025-02-25 23:26:19.342536 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-25 23:26:19.404361 | ubuntu-noble | ok 2025-02-25 23:26:19.433534 | ubuntu-noble | included: /var/lib/zuul/builds/e85114c5b8da46239de5f7ac7affc209/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-25 23:26:19.478554 | 2025-02-25 23:26:19.478692 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-25 23:26:19.523649 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:19.547220 | 2025-02-25 23:26:19.547325 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-25 23:26:20.275880 | ubuntu-noble | changed 2025-02-25 23:26:20.287887 | 2025-02-25 23:26:20.287993 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-25 23:26:20.664179 | ubuntu-noble | ok 2025-02-25 23:26:20.670471 | 2025-02-25 23:26:20.670548 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-25 23:26:21.421077 | ubuntu-noble | changed 2025-02-25 23:26:21.427972 | 2025-02-25 23:26:21.428061 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-25 23:26:22.212883 | ubuntu-noble | changed 2025-02-25 23:26:22.219210 | 2025-02-25 23:26:22.219283 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-25 23:26:22.242870 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:22.249742 | 2025-02-25 23:26:22.249817 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-25 23:26:22.671911 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:22.685281 | 2025-02-25 23:26:22.685452 | TASK [add-build-sshkey : Add back temp key] 2025-02-25 23:26:23.056962 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/e85114c5b8da46239de5f7ac7affc209/work/e85114c5b8da46239de5f7ac7affc209_id_rsa (zuul-build-sshkey) 2025-02-25 23:26:23.057204 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009379 2025-02-25 23:26:23.067085 | 2025-02-25 23:26:23.067179 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-25 23:26:23.561376 | ubuntu-noble | ok 2025-02-25 23:26:23.567830 | 2025-02-25 23:26:23.567909 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-25 23:26:23.601685 | ubuntu-noble | skipping: Conditional result was False 2025-02-25 23:26:23.625540 | 2025-02-25 23:26:23.625657 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-25 23:26:24.061058 | ubuntu-noble | ok 2025-02-25 23:26:24.076712 | 2025-02-25 23:26:24.076819 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-25 23:26:24.106999 | ubuntu-noble | ok 2025-02-25 23:26:24.113504 | 2025-02-25 23:26:24.113597 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-25 23:26:24.377535 | ubuntu-noble -> localhost | ok 2025-02-25 23:26:24.385266 | 2025-02-25 23:26:24.385351 | TASK [validate-host : Collect information about the host] 2025-02-25 23:26:25.602495 | ubuntu-noble | ok 2025-02-25 23:26:25.617352 | 2025-02-25 23:26:25.617448 | TASK [validate-host : Sanitize hostname] 2025-02-25 23:26:25.692887 | ubuntu-noble | ok 2025-02-25 23:26:25.703262 | 2025-02-25 23:26:25.703354 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-25 23:26:26.196338 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:26.209814 | 2025-02-25 23:26:26.209949 | TASK [validate-host : Collect information about zuul worker] 2025-02-25 23:26:26.697717 | ubuntu-noble | ok 2025-02-25 23:26:26.706753 | 2025-02-25 23:26:26.706868 | TASK [validate-host : Write out all zuul information for each host] 2025-02-25 23:26:27.240371 | ubuntu-noble -> localhost | changed 2025-02-25 23:26:27.253444 | 2025-02-25 23:26:27.253616 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-25 23:26:27.589723 | ubuntu-noble | ok 2025-02-25 23:26:27.600691 | 2025-02-25 23:26:27.600822 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-25 23:26:28.748630 | ubuntu-noble | changed: 2025-02-25 23:26:28.748893 | ubuntu-noble | cd+++++++++ src/ 2025-02-25 23:26:28.748937 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-25 23:26:28.748970 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-25 23:26:28.748999 | ubuntu-noble | cd+++++++++ src/github.com/osism/ansible-collection-services/ 2025-02-25 23:26:28.749024 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.020734 2025-02-25 23:27:07.017752 | 2025-02-25 23:27:07.019293 | TASK [upload-logs : Upload logs to log server] 2025-02-25 23:27:07.668450 | localhost | Output suppressed because no_log was given 2025-02-25 23:27:07.671856 | 2025-02-25 23:27:07.671966 | LOOP [upload-logs : Compress console log and json output] 2025-02-25 23:27:07.747189 | localhost | skipping: Conditional result was False 2025-02-25 23:27:07.774296 | localhost | skipping: Conditional result was False 2025-02-25 23:27:07.783260 | 2025-02-25 23:27:07.783422 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-25 23:27:07.862397 | localhost | skipping: Conditional result was False 2025-02-25 23:27:07.863459 | 2025-02-25 23:27:07.881100 | localhost | skipping: Conditional result was False 2025-02-25 23:27:07.895757 | 2025-02-25 23:27:07.895871 | LOOP [upload-logs : Upload console log and json output]