2025-10-12 00:18:52.514229 | Job console starting 2025-10-12 00:18:52.535157 | Updating git repos 2025-10-12 00:18:52.574323 | Cloning repos into workspace 2025-10-12 00:18:52.682313 | Restoring repo states 2025-10-12 00:18:52.698575 | Merging changes 2025-10-12 00:18:53.252918 | Checking out repos 2025-10-12 00:18:53.272691 | Preparing playbooks 2025-10-12 00:18:53.965224 | Running Ansible setup 2025-10-12 00:18:58.153224 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-12 00:18:59.052006 | 2025-10-12 00:18:59.052130 | PLAY [Base pre] 2025-10-12 00:18:59.066988 | 2025-10-12 00:18:59.067100 | TASK [Setup log path fact] 2025-10-12 00:18:59.084888 | debian-bookworm | ok 2025-10-12 00:18:59.100465 | 2025-10-12 00:18:59.100589 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-12 00:18:59.139869 | debian-bookworm | ok 2025-10-12 00:18:59.160194 | 2025-10-12 00:18:59.160313 | TASK [emit-job-header : Print job information] 2025-10-12 00:18:59.200363 | # Job Information 2025-10-12 00:18:59.200521 | Ansible Version: 2.16.14 2025-10-12 00:18:59.200557 | Job: python-black 2025-10-12 00:18:59.200591 | Pipeline: check 2025-10-12 00:18:59.200615 | Executor: 521e9411259a 2025-10-12 00:18:59.200637 | Triggered by: https://github.com/osism/openstack-image-manager/pull/936 2025-10-12 00:18:59.200659 | Event ID: d588b430-a700-11f0-99ac-4186e919a408 2025-10-12 00:18:59.205325 | 2025-10-12 00:18:59.205415 | LOOP [emit-job-header : Print node information] 2025-10-12 00:18:59.321135 | debian-bookworm | ok: 2025-10-12 00:18:59.321369 | debian-bookworm | # Node Information 2025-10-12 00:18:59.321404 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-12 00:18:59.321429 | debian-bookworm | Hostname: debian 2025-10-12 00:18:59.321452 | debian-bookworm | Username: zuul 2025-10-12 00:18:59.321473 | debian-bookworm | Distro: Debian 12.12 2025-10-12 00:18:59.321497 | debian-bookworm | Provider: regiocloud-a 2025-10-12 00:18:59.321518 | debian-bookworm | Region: 2025-10-12 00:18:59.321539 | debian-bookworm | Label: debian-bookworm 2025-10-12 00:18:59.321559 | debian-bookworm | Product Name: OpenStack Nova 2025-10-12 00:18:59.321579 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:958f 2025-10-12 00:18:59.339272 | 2025-10-12 00:18:59.339380 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-12 00:18:59.835618 | debian-bookworm -> localhost | changed 2025-10-12 00:18:59.843188 | 2025-10-12 00:18:59.843295 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-12 00:19:01.312491 | debian-bookworm -> localhost | changed 2025-10-12 00:19:01.323745 | 2025-10-12 00:19:01.323842 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-12 00:19:01.801367 | debian-bookworm -> localhost | ok 2025-10-12 00:19:01.807233 | 2025-10-12 00:19:01.807331 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-12 00:19:01.844789 | debian-bookworm | ok 2025-10-12 00:19:01.894194 | debian-bookworm | included: /var/lib/zuul/builds/e093493e003e45a8badc7e688e39c0a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-12 00:19:01.916173 | 2025-10-12 00:19:01.916277 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-12 00:19:05.761720 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-12 00:19:05.761907 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e093493e003e45a8badc7e688e39c0a5/work/e093493e003e45a8badc7e688e39c0a5_id_rsa 2025-10-12 00:19:05.761939 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e093493e003e45a8badc7e688e39c0a5/work/e093493e003e45a8badc7e688e39c0a5_id_rsa.pub 2025-10-12 00:19:05.761971 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-12 00:19:05.761992 | debian-bookworm -> localhost | SHA256:CyBpTsrYZpXBMVlBDk+yGRCw7PAFfDfRUJauxW9GXjo zuul-build-sshkey 2025-10-12 00:19:05.762011 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-12 00:19:05.762035 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-12 00:19:05.762053 | debian-bookworm -> localhost | |.o++B=B*o. | 2025-10-12 00:19:05.762070 | debian-bookworm -> localhost | |...o+&o.o | 2025-10-12 00:19:05.762086 | debian-bookworm -> localhost | |o.=.B.o+ | 2025-10-12 00:19:05.762102 | debian-bookworm -> localhost | |=B + . + . . | 2025-10-12 00:19:05.762117 | debian-bookworm -> localhost | |oo* .oS+ o | 2025-10-12 00:19:05.762137 | debian-bookworm -> localhost | | o .. .E | 2025-10-12 00:19:05.762153 | debian-bookworm -> localhost | | .o . | 2025-10-12 00:19:05.762168 | debian-bookworm -> localhost | | | 2025-10-12 00:19:05.762185 | debian-bookworm -> localhost | | | 2025-10-12 00:19:05.762201 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-12 00:19:05.762243 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.530177 2025-10-12 00:19:05.768099 | 2025-10-12 00:19:05.768180 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-12 00:19:05.815290 | debian-bookworm | ok 2025-10-12 00:19:05.837950 | debian-bookworm | included: /var/lib/zuul/builds/e093493e003e45a8badc7e688e39c0a5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-12 00:19:05.853486 | 2025-10-12 00:19:05.853579 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-12 00:19:05.886286 | debian-bookworm | skipping: Conditional result was False 2025-10-12 00:19:05.893297 | 2025-10-12 00:19:05.893384 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-12 00:19:06.547298 | debian-bookworm | changed 2025-10-12 00:19:06.553355 | 2025-10-12 00:19:06.553441 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-12 00:19:06.796198 | debian-bookworm | ok 2025-10-12 00:19:06.802053 | 2025-10-12 00:19:06.802141 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-12 00:19:07.437470 | debian-bookworm | changed 2025-10-12 00:19:07.448376 | 2025-10-12 00:19:07.448476 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-12 00:19:08.091469 | debian-bookworm | changed 2025-10-12 00:19:08.096584 | 2025-10-12 00:19:08.096729 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-12 00:19:08.109230 | debian-bookworm | skipping: Conditional result was False 2025-10-12 00:19:08.114569 | 2025-10-12 00:19:08.114646 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-12 00:19:08.507598 | debian-bookworm -> localhost | changed 2025-10-12 00:19:08.529445 | 2025-10-12 00:19:08.529561 | TASK [add-build-sshkey : Add back temp key] 2025-10-12 00:19:08.787346 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e093493e003e45a8badc7e688e39c0a5/work/e093493e003e45a8badc7e688e39c0a5_id_rsa (zuul-build-sshkey) 2025-10-12 00:19:08.787882 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018464 2025-10-12 00:19:08.804316 | 2025-10-12 00:19:08.804461 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-12 00:19:09.170492 | debian-bookworm | ok 2025-10-12 00:19:09.178709 | 2025-10-12 00:19:09.180748 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-12 00:19:09.193479 | debian-bookworm | skipping: Conditional result was False 2025-10-12 00:19:09.203496 | 2025-10-12 00:19:09.203580 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-12 00:19:09.580394 | debian-bookworm | ok 2025-10-12 00:19:09.592825 | 2025-10-12 00:19:09.592916 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-12 00:19:09.620598 | debian-bookworm | ok 2025-10-12 00:19:09.625460 | 2025-10-12 00:19:09.625539 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-12 00:19:09.903377 | debian-bookworm -> localhost | ok 2025-10-12 00:19:09.909501 | 2025-10-12 00:19:09.909574 | TASK [validate-host : Collect information about the host] 2025-10-12 00:19:11.019857 | debian-bookworm | ok 2025-10-12 00:19:11.028063 | 2025-10-12 00:19:11.028146 | TASK [validate-host : Sanitize hostname] 2025-10-12 00:19:11.105507 | debian-bookworm | ok 2025-10-12 00:19:11.131545 | 2025-10-12 00:19:11.131637 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-12 00:19:11.739291 | debian-bookworm -> localhost | changed 2025-10-12 00:19:11.744576 | 2025-10-12 00:19:11.744661 | TASK [validate-host : Collect information about zuul worker] 2025-10-12 00:19:12.210354 | debian-bookworm | ok 2025-10-12 00:19:12.217600 | 2025-10-12 00:19:12.217766 | TASK [validate-host : Write out all zuul information for each host] 2025-10-12 00:19:12.695878 | debian-bookworm -> localhost | changed 2025-10-12 00:19:12.705051 | 2025-10-12 00:19:12.705142 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-12 00:19:13.015306 | debian-bookworm | ok 2025-10-12 00:19:13.020503 | 2025-10-12 00:19:13.020592 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-12 00:19:14.099291 | debian-bookworm | changed: 2025-10-12 00:19:14.099518 | debian-bookworm | cd+++++++++ src/ 2025-10-12 00:19:14.099567 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-12 00:19:14.099599 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-12 00:19:14.099628 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-12 00:19:14.099656 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007283 2025-10-12 00:19:39.521469 | 2025-10-12 00:19:39.521591 | TASK [upload-logs : Upload logs to log server] 2025-10-12 00:19:40.075133 | localhost | Output suppressed because no_log was given 2025-10-12 00:19:40.077809 | 2025-10-12 00:19:40.078004 | LOOP [upload-logs : Compress console log and json output] 2025-10-12 00:19:40.136196 | localhost | skipping: Conditional result was False 2025-10-12 00:19:40.141725 | localhost | skipping: Conditional result was False 2025-10-12 00:19:40.148838 | 2025-10-12 00:19:40.149120 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-12 00:19:40.194446 | localhost | skipping: Conditional result was False 2025-10-12 00:19:40.194897 | 2025-10-12 00:19:40.199292 | localhost | skipping: Conditional result was False 2025-10-12 00:19:40.212084 | 2025-10-12 00:19:40.212331 | LOOP [upload-logs : Upload console log and json output]