2025-03-23 00:08:04.006832 | Job console starting... 2025-03-23 00:08:04.017573 | Updating repositories 2025-03-23 00:08:04.039318 | Preparing job workspace 2025-03-23 00:08:05.527059 | Running Ansible setup... 2025-03-23 00:08:10.720901 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-03-23 00:08:11.438270 | 2025-03-23 00:08:11.438419 | PLAY [Base pre] 2025-03-23 00:08:11.467367 | 2025-03-23 00:08:11.467487 | TASK [Setup log path fact] 2025-03-23 00:08:11.499771 | ubuntu-noble | ok 2025-03-23 00:08:11.518134 | 2025-03-23 00:08:11.518256 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-03-23 00:08:11.563849 | ubuntu-noble | ok 2025-03-23 00:08:11.579514 | 2025-03-23 00:08:11.579618 | TASK [emit-job-header : Print job information] 2025-03-23 00:08:11.649609 | # Job Information 2025-03-23 00:08:11.649861 | Ansible Version: 2.15.3 2025-03-23 00:08:11.649919 | Job: python-black 2025-03-23 00:08:11.649972 | Pipeline: check 2025-03-23 00:08:11.650009 | Executor: 7d211f194f6a 2025-03-23 00:08:11.650042 | Triggered by: https://github.com/osism/testbed/pull/2632 2025-03-23 00:08:11.650074 | Event ID: cbbb4e20-077a-11f0-8126-52d7bc27f283 2025-03-23 00:08:11.660300 | 2025-03-23 00:08:11.660471 | LOOP [emit-job-header : Print node information] 2025-03-23 00:08:11.809922 | ubuntu-noble | ok: 2025-03-23 00:08:11.810103 | ubuntu-noble | # Node Information 2025-03-23 00:08:11.810139 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-03-23 00:08:11.810164 | ubuntu-noble | Hostname: ubuntu 2025-03-23 00:08:11.810185 | ubuntu-noble | Username: zuul 2025-03-23 00:08:11.810206 | ubuntu-noble | Distro: Ubuntu 24.04 2025-03-23 00:08:11.810236 | ubuntu-noble | Provider: regiocloud-a 2025-03-23 00:08:11.810263 | ubuntu-noble | Label: ubuntu-noble 2025-03-23 00:08:11.810291 | ubuntu-noble | Product Name: OpenStack Nova 2025-03-23 00:08:11.810317 | ubuntu-noble | Interface IP: 81.163.193.125 2025-03-23 00:08:11.832193 | 2025-03-23 00:08:11.832317 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-03-23 00:08:12.363281 | ubuntu-noble -> localhost | changed 2025-03-23 00:08:12.377433 | 2025-03-23 00:08:12.377550 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-03-23 00:08:13.448250 | ubuntu-noble -> localhost | changed 2025-03-23 00:08:13.469771 | 2025-03-23 00:08:13.469978 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-03-23 00:08:13.752277 | ubuntu-noble -> localhost | ok 2025-03-23 00:08:13.770171 | 2025-03-23 00:08:13.770321 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-03-23 00:08:13.808732 | ubuntu-noble | ok 2025-03-23 00:08:13.829081 | ubuntu-noble | included: /var/lib/zuul/builds/30ecd9df862a4dceadb3828f276c8cb9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-03-23 00:08:13.837576 | 2025-03-23 00:08:13.837678 | TASK [add-build-sshkey : Create Temp SSH key] 2025-03-23 00:08:14.461850 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-03-23 00:08:14.462234 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/30ecd9df862a4dceadb3828f276c8cb9/work/30ecd9df862a4dceadb3828f276c8cb9_id_rsa 2025-03-23 00:08:14.462304 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/30ecd9df862a4dceadb3828f276c8cb9/work/30ecd9df862a4dceadb3828f276c8cb9_id_rsa.pub 2025-03-23 00:08:14.462357 | ubuntu-noble -> localhost | The key fingerprint is: 2025-03-23 00:08:14.462408 | ubuntu-noble -> localhost | SHA256:U+3c8aRBcysiZC03ONA9QtcwzenE6om5v8vaKbXo28o zuul-build-sshkey 2025-03-23 00:08:14.462454 | ubuntu-noble -> localhost | The key's randomart image is: 2025-03-23 00:08:14.462498 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-03-23 00:08:14.462540 | ubuntu-noble -> localhost | | .++++* + .| 2025-03-23 00:08:14.462580 | ubuntu-noble -> localhost | | o*.B.O o.| 2025-03-23 00:08:14.462621 | ubuntu-noble -> localhost | | .*.B.o..| 2025-03-23 00:08:14.462678 | ubuntu-noble -> localhost | | ..+.o.* | 2025-03-23 00:08:14.462746 | ubuntu-noble -> localhost | | S + + o .| 2025-03-23 00:08:14.462790 | ubuntu-noble -> localhost | | + + | 2025-03-23 00:08:14.462843 | ubuntu-noble -> localhost | | + . | 2025-03-23 00:08:14.462886 | ubuntu-noble -> localhost | | .++.. | 2025-03-23 00:08:14.462930 | ubuntu-noble -> localhost | | .E*Oo | 2025-03-23 00:08:14.462970 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-03-23 00:08:14.463070 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.126420 2025-03-23 00:08:14.476593 | 2025-03-23 00:08:14.476775 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-03-23 00:08:14.514680 | ubuntu-noble | ok 2025-03-23 00:08:14.527218 | ubuntu-noble | included: /var/lib/zuul/builds/30ecd9df862a4dceadb3828f276c8cb9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-03-23 00:08:14.537334 | 2025-03-23 00:08:14.537435 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-03-23 00:08:14.572094 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 00:08:14.580779 | 2025-03-23 00:08:14.580896 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-03-23 00:08:15.460525 | ubuntu-noble | changed 2025-03-23 00:08:15.473528 | 2025-03-23 00:08:15.473659 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-03-23 00:08:15.860233 | ubuntu-noble | ok 2025-03-23 00:08:15.869597 | 2025-03-23 00:08:15.869736 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-03-23 00:08:16.690504 | ubuntu-noble | changed 2025-03-23 00:08:16.697967 | 2025-03-23 00:08:16.698087 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-03-23 00:08:17.449262 | ubuntu-noble | changed 2025-03-23 00:08:17.459843 | 2025-03-23 00:08:17.459968 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-03-23 00:08:17.485282 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 00:08:17.493629 | 2025-03-23 00:08:17.493749 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-03-23 00:08:17.946511 | ubuntu-noble -> localhost | changed 2025-03-23 00:08:17.970007 | 2025-03-23 00:08:17.970189 | TASK [add-build-sshkey : Add back temp key] 2025-03-23 00:08:18.305691 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/30ecd9df862a4dceadb3828f276c8cb9/work/30ecd9df862a4dceadb3828f276c8cb9_id_rsa (zuul-build-sshkey) 2025-03-23 00:08:18.305996 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008510 2025-03-23 00:08:18.314328 | 2025-03-23 00:08:18.314449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-03-23 00:08:18.744203 | ubuntu-noble | ok 2025-03-23 00:08:18.754535 | 2025-03-23 00:08:18.754661 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-03-23 00:08:18.790686 | ubuntu-noble | skipping: Conditional result was False 2025-03-23 00:08:18.807241 | 2025-03-23 00:08:18.807353 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-03-23 00:08:19.292546 | ubuntu-noble | ok 2025-03-23 00:08:19.339972 | 2025-03-23 00:08:19.340089 | TASK [validate-host : Define zuul_info_dir fact] 2025-03-23 00:08:19.382382 | ubuntu-noble | ok 2025-03-23 00:08:19.389377 | 2025-03-23 00:08:19.389481 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-03-23 00:08:19.688935 | ubuntu-noble -> localhost | ok 2025-03-23 00:08:19.696765 | 2025-03-23 00:08:19.696878 | TASK [validate-host : Collect information about the host] 2025-03-23 00:08:20.853749 | ubuntu-noble | ok 2025-03-23 00:08:20.867413 | 2025-03-23 00:08:20.867539 | TASK [validate-host : Sanitize hostname] 2025-03-23 00:08:20.972964 | ubuntu-noble | ok 2025-03-23 00:08:20.983831 | 2025-03-23 00:08:20.983952 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-03-23 00:08:21.649150 | ubuntu-noble -> localhost | changed 2025-03-23 00:08:21.661549 | 2025-03-23 00:08:21.661788 | TASK [validate-host : Collect information about zuul worker] 2025-03-23 00:08:22.185344 | ubuntu-noble | ok 2025-03-23 00:08:22.192925 | 2025-03-23 00:08:22.193044 | TASK [validate-host : Write out all zuul information for each host] 2025-03-23 00:08:22.828519 | ubuntu-noble -> localhost | changed 2025-03-23 00:08:22.842219 | 2025-03-23 00:08:22.842333 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-03-23 00:08:23.181600 | ubuntu-noble | ok 2025-03-23 00:08:23.189640 | 2025-03-23 00:08:23.189784 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-03-23 00:08:24.479056 | ubuntu-noble | changed: 2025-03-23 00:08:24.479257 | ubuntu-noble | cd+++++++++ src/ 2025-03-23 00:08:24.479291 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-03-23 00:08:24.479315 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-03-23 00:08:24.479336 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-03-23 00:08:24.479356 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.007599 2025-03-23 00:08:58.376083 | 2025-03-23 00:08:58.376202 | TASK [upload-logs : Upload logs to log server] 2025-03-23 00:08:59.024475 | localhost | Output suppressed because no_log was given 2025-03-23 00:08:59.029979 | 2025-03-23 00:08:59.030106 | LOOP [upload-logs : Compress console log and json output] 2025-03-23 00:08:59.105964 | localhost | skipping: Conditional result was False 2025-03-23 00:08:59.125456 | localhost | skipping: Conditional result was False 2025-03-23 00:08:59.138125 | 2025-03-23 00:08:59.138373 | LOOP [upload-logs : Upload compressed console log and json output] 2025-03-23 00:08:59.217151 | localhost | skipping: Conditional result was False 2025-03-23 00:08:59.217453 | 2025-03-23 00:08:59.230635 | localhost | skipping: Conditional result was False 2025-03-23 00:08:59.243031 | 2025-03-23 00:08:59.243160 | LOOP [upload-logs : Upload console log and json output]