2025-11-20 16:37:50.484399 | Job console starting 2025-11-20 16:37:50.501541 | Updating git repos 2025-11-20 16:37:50.529870 | Cloning repos into workspace 2025-11-20 16:37:50.595767 | Restoring repo states 2025-11-20 16:37:50.610952 | Merging changes 2025-11-20 16:37:51.114153 | Checking out repos 2025-11-20 16:37:51.161766 | Preparing playbooks 2025-11-20 16:37:51.898741 | Running Ansible setup 2025-11-20 16:37:56.730091 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-20 16:37:58.282270 | 2025-11-20 16:37:58.282444 | PLAY [Base pre] 2025-11-20 16:37:58.319308 | 2025-11-20 16:37:58.319462 | TASK [Setup log path fact] 2025-11-20 16:37:58.352726 | debian-bookworm | ok 2025-11-20 16:37:58.387671 | 2025-11-20 16:37:58.387852 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-20 16:37:58.439235 | debian-bookworm | ok 2025-11-20 16:37:58.464621 | 2025-11-20 16:37:58.464765 | TASK [emit-job-header : Print job information] 2025-11-20 16:37:58.533111 | # Job Information 2025-11-20 16:37:58.533411 | Ansible Version: 2.16.14 2025-11-20 16:37:58.533449 | Job: python-black 2025-11-20 16:37:58.533488 | Pipeline: check 2025-11-20 16:37:58.533512 | Executor: 521e9411259a 2025-11-20 16:37:58.533532 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-11-20 16:37:58.533555 | Event ID: 3a7d7b30-c62f-11f0-941a-5c5359af9050 2025-11-20 16:37:58.549811 | 2025-11-20 16:37:58.549969 | LOOP [emit-job-header : Print node information] 2025-11-20 16:37:58.799009 | debian-bookworm | ok: 2025-11-20 16:37:58.799362 | debian-bookworm | # Node Information 2025-11-20 16:37:58.799408 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-20 16:37:58.799435 | debian-bookworm | Hostname: debian 2025-11-20 16:37:58.799457 | debian-bookworm | Username: zuul 2025-11-20 16:37:58.799478 | debian-bookworm | Distro: Debian 12.12 2025-11-20 16:37:58.799501 | debian-bookworm | Provider: regiocloud-a 2025-11-20 16:37:58.799522 | debian-bookworm | Region: 2025-11-20 16:37:58.799583 | debian-bookworm | Label: debian-bookworm 2025-11-20 16:37:58.799603 | debian-bookworm | Product Name: OpenStack Nova 2025-11-20 16:37:58.799623 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe75:87a1 2025-11-20 16:37:58.812335 | 2025-11-20 16:37:58.812469 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-20 16:38:00.024296 | debian-bookworm -> localhost | changed 2025-11-20 16:38:00.034070 | 2025-11-20 16:38:00.034242 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-20 16:38:02.203904 | debian-bookworm -> localhost | changed 2025-11-20 16:38:02.227664 | 2025-11-20 16:38:02.227808 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-20 16:38:02.720391 | debian-bookworm -> localhost | ok 2025-11-20 16:38:02.726784 | 2025-11-20 16:38:02.726948 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-20 16:38:02.766106 | debian-bookworm | ok 2025-11-20 16:38:02.804221 | debian-bookworm | included: /var/lib/zuul/builds/b00dc7a4614e47b8b99ae4922de8b899/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-20 16:38:02.810765 | 2025-11-20 16:38:02.818976 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-20 16:38:05.344168 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-20 16:38:05.344452 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b00dc7a4614e47b8b99ae4922de8b899/work/b00dc7a4614e47b8b99ae4922de8b899_id_rsa 2025-11-20 16:38:05.344495 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b00dc7a4614e47b8b99ae4922de8b899/work/b00dc7a4614e47b8b99ae4922de8b899_id_rsa.pub 2025-11-20 16:38:05.344523 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-20 16:38:05.344546 | debian-bookworm -> localhost | SHA256:r77tIBvnJQ+FS1L6mE+kiwi9CEBKSvW05S9xPf10zzk zuul-build-sshkey 2025-11-20 16:38:05.344569 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-20 16:38:05.344607 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-20 16:38:05.344629 | debian-bookworm -> localhost | | . . . | 2025-11-20 16:38:05.344651 | debian-bookworm -> localhost | | . o + . . | 2025-11-20 16:38:05.344672 | debian-bookworm -> localhost | | + o o.. o . ..| 2025-11-20 16:38:05.344692 | debian-bookworm -> localhost | |* o+. . o.+| 2025-11-20 16:38:05.344712 | debian-bookworm -> localhost | |+ o.S.. Eo| 2025-11-20 16:38:05.344736 | debian-bookworm -> localhost | |.. O.+ .| 2025-11-20 16:38:05.344756 | debian-bookworm -> localhost | |o . * O o | 2025-11-20 16:38:05.344776 | debian-bookworm -> localhost | |.o o . X O | 2025-11-20 16:38:05.344798 | debian-bookworm -> localhost | |. o . o.*o+ | 2025-11-20 16:38:05.344818 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-20 16:38:05.344875 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.686232 2025-11-20 16:38:05.351660 | 2025-11-20 16:38:05.351784 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-20 16:38:05.402328 | debian-bookworm | ok 2025-11-20 16:38:05.418424 | debian-bookworm | included: /var/lib/zuul/builds/b00dc7a4614e47b8b99ae4922de8b899/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-20 16:38:05.450352 | 2025-11-20 16:38:05.450500 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-20 16:38:05.494985 | debian-bookworm | skipping: Conditional result was False 2025-11-20 16:38:05.501656 | 2025-11-20 16:38:05.501787 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-20 16:38:06.405039 | debian-bookworm | changed 2025-11-20 16:38:06.423236 | 2025-11-20 16:38:06.423384 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-20 16:38:06.736636 | debian-bookworm | ok 2025-11-20 16:38:06.742338 | 2025-11-20 16:38:06.742457 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-20 16:38:07.527458 | debian-bookworm | changed 2025-11-20 16:38:07.534828 | 2025-11-20 16:38:07.535895 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-20 16:38:08.264988 | debian-bookworm | changed 2025-11-20 16:38:08.270697 | 2025-11-20 16:38:08.270857 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-20 16:38:08.311103 | debian-bookworm | skipping: Conditional result was False 2025-11-20 16:38:08.318027 | 2025-11-20 16:38:08.318190 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-20 16:38:09.043087 | debian-bookworm -> localhost | changed 2025-11-20 16:38:09.065193 | 2025-11-20 16:38:09.065351 | TASK [add-build-sshkey : Add back temp key] 2025-11-20 16:38:09.846063 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b00dc7a4614e47b8b99ae4922de8b899/work/b00dc7a4614e47b8b99ae4922de8b899_id_rsa (zuul-build-sshkey) 2025-11-20 16:38:09.846358 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.031826 2025-11-20 16:38:09.854724 | 2025-11-20 16:38:09.854894 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-20 16:38:10.411318 | debian-bookworm | ok 2025-11-20 16:38:10.417284 | 2025-11-20 16:38:10.417412 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-20 16:38:10.466203 | debian-bookworm | skipping: Conditional result was False 2025-11-20 16:38:10.478611 | 2025-11-20 16:38:10.478759 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-20 16:38:11.001674 | debian-bookworm | ok 2025-11-20 16:38:11.022283 | 2025-11-20 16:38:11.022436 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-20 16:38:11.084387 | debian-bookworm | ok 2025-11-20 16:38:11.090322 | 2025-11-20 16:38:11.090476 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-20 16:38:11.591704 | debian-bookworm -> localhost | ok 2025-11-20 16:38:11.598472 | 2025-11-20 16:38:11.598594 | TASK [validate-host : Collect information about the host] 2025-11-20 16:38:13.149437 | debian-bookworm | ok 2025-11-20 16:38:13.172265 | 2025-11-20 16:38:13.172408 | TASK [validate-host : Sanitize hostname] 2025-11-20 16:38:13.353972 | debian-bookworm | ok 2025-11-20 16:38:13.400992 | 2025-11-20 16:38:13.401176 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-20 16:38:14.201027 | debian-bookworm -> localhost | changed 2025-11-20 16:38:14.207424 | 2025-11-20 16:38:14.207550 | TASK [validate-host : Collect information about zuul worker] 2025-11-20 16:38:14.708232 | debian-bookworm | ok 2025-11-20 16:38:14.714049 | 2025-11-20 16:38:14.714204 | TASK [validate-host : Write out all zuul information for each host] 2025-11-20 16:38:15.627560 | debian-bookworm -> localhost | changed 2025-11-20 16:38:15.641091 | 2025-11-20 16:38:15.641326 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-20 16:38:15.944093 | debian-bookworm | ok 2025-11-20 16:38:15.956901 | 2025-11-20 16:38:15.957039 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-20 16:38:17.459700 | debian-bookworm | changed: 2025-11-20 16:38:17.459944 | debian-bookworm | cd+++++++++ src/ 2025-11-20 16:38:17.459983 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-20 16:38:17.460008 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-20 16:38:17.460030 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-20 16:38:17.460050 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004930 2025-11-20 16:38:45.369251 | 2025-11-20 16:38:45.369378 | TASK [upload-logs : Upload logs to log server] 2025-11-20 16:38:46.158866 | localhost | Output suppressed because no_log was given 2025-11-20 16:38:46.160828 | 2025-11-20 16:38:46.160933 | LOOP [upload-logs : Compress console log and json output] 2025-11-20 16:38:46.222346 | localhost | skipping: Conditional result was False 2025-11-20 16:38:46.228761 | localhost | skipping: Conditional result was False 2025-11-20 16:38:46.238215 | 2025-11-20 16:38:46.238348 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-20 16:38:46.352487 | localhost | skipping: Conditional result was False 2025-11-20 16:38:46.352797 | 2025-11-20 16:38:46.372549 | localhost | skipping: Conditional result was False 2025-11-20 16:38:46.376652 | 2025-11-20 16:38:46.376781 | LOOP [upload-logs : Upload console log and json output]