2025-12-10 10:59:37.162412 | Job console starting 2025-12-10 10:59:37.179263 | Updating git repos 2025-12-10 10:59:37.525416 | Cloning repos into workspace 2025-12-10 10:59:37.598346 | Restoring repo states 2025-12-10 10:59:37.604462 | Merging changes 2025-12-10 10:59:38.161214 | Checking out repos 2025-12-10 10:59:38.226239 | Preparing playbooks 2025-12-10 10:59:39.518374 | Running Ansible setup 2025-12-10 10:59:45.646574 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-10 10:59:47.058538 | 2025-12-10 10:59:47.058706 | PLAY [Base pre] 2025-12-10 10:59:47.103711 | 2025-12-10 10:59:47.103883 | TASK [Setup log path fact] 2025-12-10 10:59:47.144984 | debian-bookworm | ok 2025-12-10 10:59:47.182349 | 2025-12-10 10:59:47.182613 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-10 10:59:47.242502 | debian-bookworm | ok 2025-12-10 10:59:47.255786 | 2025-12-10 10:59:47.255949 | TASK [emit-job-header : Print job information] 2025-12-10 10:59:47.295627 | # Job Information 2025-12-10 10:59:47.295814 | Ansible Version: 2.16.14 2025-12-10 10:59:47.295849 | Job: python-black 2025-12-10 10:59:47.295883 | Pipeline: check 2025-12-10 10:59:47.295947 | Executor: 521e9411259a 2025-12-10 10:59:47.295971 | Triggered by: https://github.com/osism/testbed/pull/2777 2025-12-10 10:59:47.295995 | Event ID: 4c4be8a0-d5b7-11f0-9d0b-1aa1c09efb26 2025-12-10 10:59:47.300855 | 2025-12-10 10:59:47.301000 | LOOP [emit-job-header : Print node information] 2025-12-10 10:59:47.423739 | debian-bookworm | ok: 2025-12-10 10:59:47.423959 | debian-bookworm | # Node Information 2025-12-10 10:59:47.423996 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-10 10:59:47.424021 | debian-bookworm | Hostname: debian 2025-12-10 10:59:47.424044 | debian-bookworm | Username: zuul 2025-12-10 10:59:47.424064 | debian-bookworm | Distro: Debian 12.12 2025-12-10 10:59:47.424094 | debian-bookworm | Provider: regiocloud-a 2025-12-10 10:59:47.424128 | debian-bookworm | Region: 2025-12-10 10:59:47.424161 | debian-bookworm | Label: debian-bookworm 2025-12-10 10:59:47.424190 | debian-bookworm | Product Name: OpenStack Nova 2025-12-10 10:59:47.424211 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe76:33bf 2025-12-10 10:59:47.474475 | 2025-12-10 10:59:47.474682 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-10 10:59:48.413440 | debian-bookworm -> localhost | changed 2025-12-10 10:59:48.420866 | 2025-12-10 10:59:48.421048 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-10 10:59:50.438198 | debian-bookworm -> localhost | changed 2025-12-10 10:59:50.455669 | 2025-12-10 10:59:50.455940 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-10 10:59:50.920835 | debian-bookworm -> localhost | ok 2025-12-10 10:59:50.927415 | 2025-12-10 10:59:50.927567 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-10 10:59:50.956731 | debian-bookworm | ok 2025-12-10 10:59:50.978095 | debian-bookworm | included: /var/lib/zuul/builds/4f6c2f5e88614840b4e32148b12e3721/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-10 10:59:50.984832 | 2025-12-10 10:59:50.984990 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-10 10:59:54.841894 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-10 10:59:54.842113 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4f6c2f5e88614840b4e32148b12e3721/work/4f6c2f5e88614840b4e32148b12e3721_id_rsa 2025-12-10 10:59:54.842153 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4f6c2f5e88614840b4e32148b12e3721/work/4f6c2f5e88614840b4e32148b12e3721_id_rsa.pub 2025-12-10 10:59:54.842181 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-10 10:59:54.842207 | debian-bookworm -> localhost | SHA256:d53kTQ7yGwW4OYvNyuIvGfw251+wTEwG8G7UnfBKnyU zuul-build-sshkey 2025-12-10 10:59:54.842231 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-10 10:59:54.842263 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-10 10:59:54.842286 | debian-bookworm -> localhost | | ...o. | 2025-12-10 10:59:54.842307 | debian-bookworm -> localhost | | ..ooo.| 2025-12-10 10:59:54.842327 | debian-bookworm -> localhost | | ++Eo=| 2025-12-10 10:59:54.842347 | debian-bookworm -> localhost | | o=XoOo| 2025-12-10 10:59:54.842366 | debian-bookworm -> localhost | | .S .+++Xoo| 2025-12-10 10:59:54.842392 | debian-bookworm -> localhost | | o..o+o = | 2025-12-10 10:59:54.842413 | debian-bookworm -> localhost | | = . + .| 2025-12-10 10:59:54.842433 | debian-bookworm -> localhost | | + * . . | 2025-12-10 10:59:54.842454 | debian-bookworm -> localhost | | ..=.+... | 2025-12-10 10:59:54.842474 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-10 10:59:54.842529 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.644132 2025-12-10 10:59:54.848530 | 2025-12-10 10:59:54.848628 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-10 10:59:54.887551 | debian-bookworm | ok 2025-12-10 10:59:54.904870 | debian-bookworm | included: /var/lib/zuul/builds/4f6c2f5e88614840b4e32148b12e3721/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-10 10:59:54.923887 | 2025-12-10 10:59:54.924048 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-10 10:59:54.937161 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:59:54.942827 | 2025-12-10 10:59:54.942974 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-10 10:59:55.706120 | debian-bookworm | changed 2025-12-10 10:59:55.715408 | 2025-12-10 10:59:55.715512 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-10 10:59:55.996350 | debian-bookworm | ok 2025-12-10 10:59:56.001865 | 2025-12-10 10:59:56.005518 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-10 10:59:56.742816 | debian-bookworm | changed 2025-12-10 10:59:56.749868 | 2025-12-10 10:59:56.749987 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-10 10:59:57.568225 | debian-bookworm | changed 2025-12-10 10:59:57.574552 | 2025-12-10 10:59:57.574644 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-10 10:59:57.603837 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:59:57.609804 | 2025-12-10 10:59:57.609896 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-10 10:59:58.250186 | debian-bookworm -> localhost | changed 2025-12-10 10:59:58.260672 | 2025-12-10 10:59:58.260779 | TASK [add-build-sshkey : Add back temp key] 2025-12-10 10:59:58.684872 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4f6c2f5e88614840b4e32148b12e3721/work/4f6c2f5e88614840b4e32148b12e3721_id_rsa (zuul-build-sshkey) 2025-12-10 10:59:58.685101 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025230 2025-12-10 10:59:58.692840 | 2025-12-10 10:59:58.692977 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-10 10:59:59.234125 | debian-bookworm | ok 2025-12-10 10:59:59.243665 | 2025-12-10 10:59:59.243790 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-10 10:59:59.267005 | debian-bookworm | skipping: Conditional result was False 2025-12-10 10:59:59.277172 | 2025-12-10 10:59:59.277290 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-10 10:59:59.723238 | debian-bookworm | ok 2025-12-10 10:59:59.746044 | 2025-12-10 10:59:59.746201 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-10 10:59:59.788614 | debian-bookworm | ok 2025-12-10 10:59:59.794385 | 2025-12-10 10:59:59.794515 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-10 11:00:00.618706 | debian-bookworm -> localhost | ok 2025-12-10 11:00:00.626428 | 2025-12-10 11:00:00.626577 | TASK [validate-host : Collect information about the host] 2025-12-10 11:00:01.999396 | debian-bookworm | ok 2025-12-10 11:00:02.024420 | 2025-12-10 11:00:02.024581 | TASK [validate-host : Sanitize hostname] 2025-12-10 11:00:02.185062 | debian-bookworm | ok 2025-12-10 11:00:02.255836 | 2025-12-10 11:00:02.256020 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-10 11:00:03.350402 | debian-bookworm -> localhost | changed 2025-12-10 11:00:03.356800 | 2025-12-10 11:00:03.356983 | TASK [validate-host : Collect information about zuul worker] 2025-12-10 11:00:03.970331 | debian-bookworm | ok 2025-12-10 11:00:03.975450 | 2025-12-10 11:00:03.975585 | TASK [validate-host : Write out all zuul information for each host] 2025-12-10 11:00:05.027580 | debian-bookworm -> localhost | changed 2025-12-10 11:00:05.037832 | 2025-12-10 11:00:05.037997 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-10 11:00:05.349341 | debian-bookworm | ok 2025-12-10 11:00:05.355600 | 2025-12-10 11:00:05.355755 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-10 11:00:07.023313 | debian-bookworm | changed: 2025-12-10 11:00:07.023535 | debian-bookworm | cd+++++++++ src/ 2025-12-10 11:00:07.023570 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-10 11:00:07.023593 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-10 11:00:07.023616 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-12-10 11:00:07.023637 | debian-bookworm | localhost | ok: Runtime: 0:00:00.024786 2025-12-10 11:00:35.005439 | 2025-12-10 11:00:35.005573 | TASK [upload-logs : Upload logs to log server] 2025-12-10 11:00:35.713133 | localhost | Output suppressed because no_log was given 2025-12-10 11:00:35.715314 | 2025-12-10 11:00:35.715430 | LOOP [upload-logs : Compress console log and json output] 2025-12-10 11:00:35.768394 | localhost | skipping: Conditional result was False 2025-12-10 11:00:35.774758 | localhost | skipping: Conditional result was False 2025-12-10 11:00:35.785301 | 2025-12-10 11:00:35.785442 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-10 11:00:35.833677 | localhost | skipping: Conditional result was False 2025-12-10 11:00:35.833993 | 2025-12-10 11:00:35.839317 | localhost | skipping: Conditional result was False 2025-12-10 11:00:35.842811 | 2025-12-10 11:00:35.843000 | LOOP [upload-logs : Upload console log and json output]