2025-04-26 11:01:16.424104 | Job console starting... 2025-04-26 11:01:16.459549 | Updating repositories 2025-04-26 11:01:16.487612 | Preparing job workspace 2025-04-26 11:01:18.065759 | Running Ansible setup... 2025-04-26 11:01:23.057528 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-26 11:01:23.837707 | 2025-04-26 11:01:23.837869 | PLAY [Base pre] 2025-04-26 11:01:23.878952 | 2025-04-26 11:01:23.879113 | TASK [Setup log path fact] 2025-04-26 11:01:23.922961 | ubuntu-noble | ok 2025-04-26 11:01:23.946759 | 2025-04-26 11:01:23.946929 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-26 11:01:23.988346 | ubuntu-noble | ok 2025-04-26 11:01:24.001487 | 2025-04-26 11:01:24.001614 | TASK [emit-job-header : Print job information] 2025-04-26 11:01:24.054406 | # Job Information 2025-04-26 11:01:24.054608 | Ansible Version: 2.15.3 2025-04-26 11:01:24.054644 | Job: python-black 2025-04-26 11:01:24.054673 | Pipeline: check 2025-04-26 11:01:24.054694 | Executor: 7d211f194f6a 2025-04-26 11:01:24.054713 | Triggered by: https://github.com/osism/testbed/pull/2671 2025-04-26 11:01:24.054733 | Event ID: c1ca2930-228d-11f0-86df-180e1020e256 2025-04-26 11:01:24.062282 | 2025-04-26 11:01:24.062431 | LOOP [emit-job-header : Print node information] 2025-04-26 11:01:24.217485 | ubuntu-noble | ok: 2025-04-26 11:01:24.217754 | ubuntu-noble | # Node Information 2025-04-26 11:01:24.217793 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-26 11:01:24.217817 | ubuntu-noble | Hostname: ubuntu 2025-04-26 11:01:24.217838 | ubuntu-noble | Username: zuul 2025-04-26 11:01:24.217859 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-26 11:01:24.217883 | ubuntu-noble | Provider: regiocloud-a 2025-04-26 11:01:24.217903 | ubuntu-noble | Label: ubuntu-noble 2025-04-26 11:01:24.217924 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-26 11:01:24.217944 | ubuntu-noble | Interface IP: 81.163.193.134 2025-04-26 11:01:24.233569 | 2025-04-26 11:01:24.233705 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-26 11:01:24.747255 | ubuntu-noble -> localhost | changed 2025-04-26 11:01:24.755924 | 2025-04-26 11:01:24.756048 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-26 11:01:25.813283 | ubuntu-noble -> localhost | changed 2025-04-26 11:01:25.830812 | 2025-04-26 11:01:25.830921 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-26 11:01:26.078937 | ubuntu-noble -> localhost | ok 2025-04-26 11:01:26.086636 | 2025-04-26 11:01:26.086740 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-26 11:01:26.119031 | ubuntu-noble | ok 2025-04-26 11:01:26.139805 | ubuntu-noble | included: /var/lib/zuul/builds/2c85a602364842a7b4a3acf24e1f3247/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-26 11:01:26.147269 | 2025-04-26 11:01:26.147386 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-26 11:01:26.799006 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-26 11:01:26.799220 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/2c85a602364842a7b4a3acf24e1f3247/work/2c85a602364842a7b4a3acf24e1f3247_id_rsa 2025-04-26 11:01:26.799257 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/2c85a602364842a7b4a3acf24e1f3247/work/2c85a602364842a7b4a3acf24e1f3247_id_rsa.pub 2025-04-26 11:01:26.799283 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-26 11:01:26.799307 | ubuntu-noble -> localhost | SHA256:ntcSCPpMaU6GK+sXgvbw4YoRVLC30vQ2BrY1vvnZiY4 zuul-build-sshkey 2025-04-26 11:01:26.799341 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-26 11:01:26.799364 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-26 11:01:26.799385 | ubuntu-noble -> localhost | | ... | 2025-04-26 11:01:26.799406 | ubuntu-noble -> localhost | | o | 2025-04-26 11:01:26.799426 | ubuntu-noble -> localhost | | o = o. | 2025-04-26 11:01:26.799454 | ubuntu-noble -> localhost | |. = Bo.o . | 2025-04-26 11:01:26.799475 | ubuntu-noble -> localhost | |.o +o** S . | 2025-04-26 11:01:26.799494 | ubuntu-noble -> localhost | |.+o.+X+. . o | 2025-04-26 11:01:26.799521 | ubuntu-noble -> localhost | |o *.o++ o o . | 2025-04-26 11:01:26.799543 | ubuntu-noble -> localhost | |.. *. o +... | 2025-04-26 11:01:26.799563 | ubuntu-noble -> localhost | |.o+. E.= o | 2025-04-26 11:01:26.799583 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-26 11:01:26.799633 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.155731 2025-04-26 11:01:26.807868 | 2025-04-26 11:01:26.807960 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-26 11:01:26.837367 | ubuntu-noble | ok 2025-04-26 11:01:26.848019 | ubuntu-noble | included: /var/lib/zuul/builds/2c85a602364842a7b4a3acf24e1f3247/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-26 11:01:26.857244 | 2025-04-26 11:01:26.857351 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-26 11:01:26.874532 | ubuntu-noble | skipping: Conditional result was False 2025-04-26 11:01:26.881595 | 2025-04-26 11:01:26.881686 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-26 11:01:27.510444 | ubuntu-noble | changed 2025-04-26 11:01:27.521227 | 2025-04-26 11:01:27.521371 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-26 11:01:27.823814 | ubuntu-noble | ok 2025-04-26 11:01:27.833179 | 2025-04-26 11:01:27.833288 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-26 11:01:28.556289 | ubuntu-noble | changed 2025-04-26 11:01:28.565388 | 2025-04-26 11:01:28.565494 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-26 11:01:29.284057 | ubuntu-noble | changed 2025-04-26 11:01:29.291375 | 2025-04-26 11:01:29.291474 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-26 11:01:29.315051 | ubuntu-noble | skipping: Conditional result was False 2025-04-26 11:01:29.322308 | 2025-04-26 11:01:29.322416 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-26 11:01:29.712350 | ubuntu-noble -> localhost | changed 2025-04-26 11:01:29.725731 | 2025-04-26 11:01:29.725828 | TASK [add-build-sshkey : Add back temp key] 2025-04-26 11:01:30.044450 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/2c85a602364842a7b4a3acf24e1f3247/work/2c85a602364842a7b4a3acf24e1f3247_id_rsa (zuul-build-sshkey) 2025-04-26 11:01:30.044653 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007244 2025-04-26 11:01:30.053126 | 2025-04-26 11:01:30.053222 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-26 11:01:30.549892 | ubuntu-noble | ok 2025-04-26 11:01:30.559390 | 2025-04-26 11:01:30.559496 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-26 11:01:30.584020 | ubuntu-noble | skipping: Conditional result was False 2025-04-26 11:01:30.600215 | 2025-04-26 11:01:30.600301 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-26 11:01:31.078538 | ubuntu-noble | ok 2025-04-26 11:01:31.126012 | 2025-04-26 11:01:31.126121 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-26 11:01:31.176124 | ubuntu-noble | ok 2025-04-26 11:01:31.188958 | 2025-04-26 11:01:31.189062 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-26 11:01:31.503923 | ubuntu-noble -> localhost | ok 2025-04-26 11:01:31.512251 | 2025-04-26 11:01:31.512346 | TASK [validate-host : Collect information about the host] 2025-04-26 11:01:32.646140 | ubuntu-noble | ok 2025-04-26 11:01:32.658223 | 2025-04-26 11:01:32.658377 | TASK [validate-host : Sanitize hostname] 2025-04-26 11:01:32.719602 | ubuntu-noble | ok 2025-04-26 11:01:32.726741 | 2025-04-26 11:01:32.726868 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-26 11:01:33.282110 | ubuntu-noble -> localhost | changed 2025-04-26 11:01:33.289754 | 2025-04-26 11:01:33.289878 | TASK [validate-host : Collect information about zuul worker] 2025-04-26 11:01:33.830977 | ubuntu-noble | ok 2025-04-26 11:01:33.845423 | 2025-04-26 11:01:33.845565 | TASK [validate-host : Write out all zuul information for each host] 2025-04-26 11:01:34.446082 | ubuntu-noble -> localhost | changed 2025-04-26 11:01:34.458609 | 2025-04-26 11:01:34.458737 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-26 11:01:34.764075 | ubuntu-noble | ok 2025-04-26 11:01:34.771308 | 2025-04-26 11:01:34.771440 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-26 11:01:35.795323 | ubuntu-noble | changed: 2025-04-26 11:01:35.795545 | ubuntu-noble | cd+++++++++ src/ 2025-04-26 11:01:35.795582 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-26 11:01:35.795608 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-26 11:01:35.795629 | ubuntu-noble | cd+++++++++ src/github.com/osism/testbed/ 2025-04-26 11:01:35.795650 | ubuntu-noble | localhost | ok: Runtime: 0:00:00.010059 2025-04-26 11:02:07.372673 | 2025-04-26 11:02:07.372811 | TASK [upload-logs : Upload logs to log server] 2025-04-26 11:02:07.953348 | localhost | Output suppressed because no_log was given 2025-04-26 11:02:07.956617 | 2025-04-26 11:02:07.956737 | LOOP [upload-logs : Compress console log and json output] 2025-04-26 11:02:08.023275 | localhost | skipping: Conditional result was False 2025-04-26 11:02:08.042970 | localhost | skipping: Conditional result was False 2025-04-26 11:02:08.056556 | 2025-04-26 11:02:08.056679 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-26 11:02:08.129821 | localhost | skipping: Conditional result was False 2025-04-26 11:02:08.130148 | 2025-04-26 11:02:08.143561 | localhost | skipping: Conditional result was False 2025-04-26 11:02:08.155646 | 2025-04-26 11:02:08.155763 | LOOP [upload-logs : Upload console log and json output]