2025-09-23 16:19:51.251993 | Job console starting 2025-09-23 16:19:51.301031 | Updating git repos 2025-09-23 16:19:51.488324 | Cloning repos into workspace 2025-09-23 16:19:51.561232 | Restoring repo states 2025-09-23 16:19:51.593657 | Merging changes 2025-09-23 16:19:52.190055 | Checking out repos 2025-09-23 16:19:52.276733 | Preparing playbooks 2025-09-23 16:19:53.720611 | Running Ansible setup 2025-09-23 16:19:59.512597 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 16:20:00.661808 | 2025-09-23 16:20:00.661955 | PLAY [Base pre] 2025-09-23 16:20:00.693249 | 2025-09-23 16:20:00.693357 | TASK [Setup log path fact] 2025-09-23 16:20:00.715302 | debian-bookworm | ok 2025-09-23 16:20:00.739400 | 2025-09-23 16:20:00.739522 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 16:20:00.793101 | debian-bookworm | ok 2025-09-23 16:20:00.809271 | 2025-09-23 16:20:00.809366 | TASK [emit-job-header : Print job information] 2025-09-23 16:20:00.886369 | # Job Information 2025-09-23 16:20:00.886519 | Ansible Version: 2.16.14 2025-09-23 16:20:00.886550 | Job: python-black 2025-09-23 16:20:00.886576 | Pipeline: check 2025-09-23 16:20:00.886595 | Executor: 521e9411259a 2025-09-23 16:20:00.886612 | Triggered by: https://github.com/osism/cfg-generics/pull/558 2025-09-23 16:20:00.886631 | Event ID: 1b8ae0f0-9899-11f0-9386-2028027f1424 2025-09-23 16:20:00.890515 | 2025-09-23 16:20:00.890597 | LOOP [emit-job-header : Print node information] 2025-09-23 16:20:01.052712 | debian-bookworm | ok: 2025-09-23 16:20:01.052883 | debian-bookworm | # Node Information 2025-09-23 16:20:01.052910 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 16:20:01.052930 | debian-bookworm | Hostname: debian 2025-09-23 16:20:01.052947 | debian-bookworm | Username: zuul 2025-09-23 16:20:01.052964 | debian-bookworm | Distro: Debian 12.12 2025-09-23 16:20:01.052985 | debian-bookworm | Provider: regiocloud-a 2025-09-23 16:20:01.053002 | debian-bookworm | Region: 2025-09-23 16:20:01.053018 | debian-bookworm | Label: debian-bookworm 2025-09-23 16:20:01.053034 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 16:20:01.053049 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:febe:807c 2025-09-23 16:20:01.063228 | 2025-09-23 16:20:01.063329 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 16:20:01.930273 | debian-bookworm -> localhost | changed 2025-09-23 16:20:01.935965 | 2025-09-23 16:20:01.936049 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 16:20:03.735733 | debian-bookworm -> localhost | changed 2025-09-23 16:20:03.744470 | 2025-09-23 16:20:03.744550 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 16:20:04.394687 | debian-bookworm -> localhost | ok 2025-09-23 16:20:04.399553 | 2025-09-23 16:20:04.399634 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 16:20:04.425818 | debian-bookworm | ok 2025-09-23 16:20:04.453783 | debian-bookworm | included: /var/lib/zuul/builds/1883284f0acf4f69a4a2ae6dd62ed390/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 16:20:04.471469 | 2025-09-23 16:20:04.471542 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 16:20:05.939611 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 16:20:05.939781 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1883284f0acf4f69a4a2ae6dd62ed390/work/1883284f0acf4f69a4a2ae6dd62ed390_id_rsa 2025-09-23 16:20:05.939813 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1883284f0acf4f69a4a2ae6dd62ed390/work/1883284f0acf4f69a4a2ae6dd62ed390_id_rsa.pub 2025-09-23 16:20:05.939834 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 16:20:05.939855 | debian-bookworm -> localhost | SHA256:OZWQi8Fcz9VxSD/raNxMrZKHlJ6Iy8qDk0tLItTKJqg zuul-build-sshkey 2025-09-23 16:20:05.939872 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 16:20:05.939897 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 16:20:05.939916 | debian-bookworm -> localhost | | o .o. .ooo.| 2025-09-23 16:20:05.939933 | debian-bookworm -> localhost | | + .+ o oo | 2025-09-23 16:20:05.939950 | debian-bookworm -> localhost | | o .= ..| 2025-09-23 16:20:05.939967 | debian-bookworm -> localhost | | . . .o . +| 2025-09-23 16:20:05.939983 | debian-bookworm -> localhost | | . . S o o.| 2025-09-23 16:20:05.940005 | debian-bookworm -> localhost | |+ . o +.+*. | 2025-09-23 16:20:05.940023 | debian-bookworm -> localhost | |++. oo . . *+o+ | 2025-09-23 16:20:05.940039 | debian-bookworm -> localhost | |+. ++o.. . .o | 2025-09-23 16:20:05.940056 | debian-bookworm -> localhost | |E ooooo | 2025-09-23 16:20:05.940073 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 16:20:05.940112 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.414806 2025-09-23 16:20:05.952068 | 2025-09-23 16:20:05.952164 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 16:20:06.015091 | debian-bookworm | ok 2025-09-23 16:20:06.022426 | debian-bookworm | included: /var/lib/zuul/builds/1883284f0acf4f69a4a2ae6dd62ed390/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 16:20:06.044022 | 2025-09-23 16:20:06.044193 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 16:20:06.058003 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:20:06.063902 | 2025-09-23 16:20:06.063986 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 16:20:06.605439 | debian-bookworm | changed 2025-09-23 16:20:06.611715 | 2025-09-23 16:20:06.611798 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 16:20:06.832281 | debian-bookworm | ok 2025-09-23 16:20:06.837870 | 2025-09-23 16:20:06.837957 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 16:20:07.394365 | debian-bookworm | changed 2025-09-23 16:20:07.400847 | 2025-09-23 16:20:07.400945 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 16:20:07.953199 | debian-bookworm | changed 2025-09-23 16:20:07.965942 | 2025-09-23 16:20:07.966042 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 16:20:07.988740 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:20:07.994384 | 2025-09-23 16:20:07.994489 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 16:20:08.423049 | debian-bookworm -> localhost | changed 2025-09-23 16:20:08.435642 | 2025-09-23 16:20:08.435746 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 16:20:08.901641 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1883284f0acf4f69a4a2ae6dd62ed390/work/1883284f0acf4f69a4a2ae6dd62ed390_id_rsa (zuul-build-sshkey) 2025-09-23 16:20:08.901853 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021418 2025-09-23 16:20:08.909193 | 2025-09-23 16:20:08.909295 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 16:20:09.394109 | debian-bookworm | ok 2025-09-23 16:20:09.408963 | 2025-09-23 16:20:09.409075 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 16:20:09.431911 | debian-bookworm | skipping: Conditional result was False 2025-09-23 16:20:09.442151 | 2025-09-23 16:20:09.442266 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 16:20:09.933191 | debian-bookworm | ok 2025-09-23 16:20:09.943103 | 2025-09-23 16:20:09.943196 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 16:20:09.970288 | debian-bookworm | ok 2025-09-23 16:20:09.975156 | 2025-09-23 16:20:09.975249 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 16:20:10.220085 | debian-bookworm -> localhost | ok 2025-09-23 16:20:10.226204 | 2025-09-23 16:20:10.226293 | TASK [validate-host : Collect information about the host] 2025-09-23 16:20:11.389292 | debian-bookworm | ok 2025-09-23 16:20:11.397815 | 2025-09-23 16:20:11.397904 | TASK [validate-host : Sanitize hostname] 2025-09-23 16:20:11.465294 | debian-bookworm | ok 2025-09-23 16:20:11.490171 | 2025-09-23 16:20:11.490254 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 16:20:12.099003 | debian-bookworm -> localhost | changed 2025-09-23 16:20:12.103411 | 2025-09-23 16:20:12.103514 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 16:20:12.576727 | debian-bookworm | ok 2025-09-23 16:20:12.581185 | 2025-09-23 16:20:12.581273 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 16:20:13.213567 | debian-bookworm -> localhost | changed 2025-09-23 16:20:13.221083 | 2025-09-23 16:20:13.221161 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 16:20:13.509577 | debian-bookworm | ok 2025-09-23 16:20:13.513877 | 2025-09-23 16:20:13.513949 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 16:20:14.412529 | debian-bookworm | changed: 2025-09-23 16:20:14.412667 | debian-bookworm | cd+++++++++ src/ 2025-09-23 16:20:14.412694 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 16:20:14.412715 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 16:20:14.412732 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-generics/ 2025-09-23 16:20:14.412748 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005251 2025-09-23 16:20:39.451790 | 2025-09-23 16:20:39.451933 | TASK [upload-logs : Upload logs to log server] 2025-09-23 16:20:40.083185 | localhost | Output suppressed because no_log was given 2025-09-23 16:20:40.085055 | 2025-09-23 16:20:40.085163 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 16:20:40.174618 | localhost | skipping: Conditional result was False 2025-09-23 16:20:40.183185 | localhost | skipping: Conditional result was False 2025-09-23 16:20:40.195250 | 2025-09-23 16:20:40.195466 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 16:20:40.246565 | localhost | skipping: Conditional result was False 2025-09-23 16:20:40.247453 | 2025-09-23 16:20:40.251814 | localhost | skipping: Conditional result was False 2025-09-23 16:20:40.262808 | 2025-09-23 16:20:40.262959 | LOOP [upload-logs : Upload console log and json output]