2025-09-16 22:50:16.932659 | Job console starting 2025-09-16 22:50:16.980181 | Updating git repos 2025-09-16 22:50:17.034244 | Cloning repos into workspace 2025-09-16 22:50:17.089034 | Restoring repo states 2025-09-16 22:50:17.127508 | Merging changes 2025-09-16 22:50:17.774943 | Checking out repos 2025-09-16 22:50:17.834960 | Preparing playbooks 2025-09-16 22:50:19.068663 | Running Ansible setup 2025-09-16 22:50:24.070763 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-16 22:50:25.146709 | 2025-09-16 22:50:25.155022 | PLAY [Base pre] 2025-09-16 22:50:25.184894 | 2025-09-16 22:50:25.185021 | TASK [Setup log path fact] 2025-09-16 22:50:25.215177 | debian-bookworm | ok 2025-09-16 22:50:25.237716 | 2025-09-16 22:50:25.237836 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-16 22:50:25.320763 | debian-bookworm | ok 2025-09-16 22:50:25.348176 | 2025-09-16 22:50:25.348323 | TASK [emit-job-header : Print job information] 2025-09-16 22:50:25.387309 | # Job Information 2025-09-16 22:50:25.387482 | Ansible Version: 2.16.14 2025-09-16 22:50:25.387517 | Job: python-black 2025-09-16 22:50:25.387550 | Pipeline: check 2025-09-16 22:50:25.387573 | Executor: 521e9411259a 2025-09-16 22:50:25.387594 | Triggered by: https://github.com/osism/container-image-osism-ansible/pull/685 2025-09-16 22:50:25.387617 | Event ID: 7edf2ca0-934f-11f0-950b-c07056edae04 2025-09-16 22:50:25.392487 | 2025-09-16 22:50:25.392587 | LOOP [emit-job-header : Print node information] 2025-09-16 22:50:25.512703 | debian-bookworm | ok: 2025-09-16 22:50:25.512877 | debian-bookworm | # Node Information 2025-09-16 22:50:25.512911 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-16 22:50:25.512937 | debian-bookworm | Hostname: debian 2025-09-16 22:50:25.512959 | debian-bookworm | Username: zuul 2025-09-16 22:50:25.512980 | debian-bookworm | Distro: Debian 12.12 2025-09-16 22:50:25.513005 | debian-bookworm | Provider: regiocloud-a 2025-09-16 22:50:25.513026 | debian-bookworm | Region: 2025-09-16 22:50:25.513047 | debian-bookworm | Label: debian-bookworm 2025-09-16 22:50:25.513068 | debian-bookworm | Product Name: OpenStack Nova 2025-09-16 22:50:25.513088 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3c:1a61 2025-09-16 22:50:25.529173 | 2025-09-16 22:50:25.529291 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-16 22:50:26.215229 | debian-bookworm -> localhost | changed 2025-09-16 22:50:26.222466 | 2025-09-16 22:50:26.222581 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-16 22:50:27.530039 | debian-bookworm -> localhost | changed 2025-09-16 22:50:27.539051 | 2025-09-16 22:50:27.539147 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-16 22:50:27.844030 | debian-bookworm -> localhost | ok 2025-09-16 22:50:27.854765 | 2025-09-16 22:50:27.854869 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-16 22:50:27.897194 | debian-bookworm | ok 2025-09-16 22:50:27.926958 | debian-bookworm | included: /var/lib/zuul/builds/f346b79201fa4640a6f5b6207c4bf7dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-16 22:50:27.932765 | 2025-09-16 22:50:27.932837 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-16 22:50:29.408975 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-16 22:50:29.409147 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f346b79201fa4640a6f5b6207c4bf7dc/work/f346b79201fa4640a6f5b6207c4bf7dc_id_rsa 2025-09-16 22:50:29.409181 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f346b79201fa4640a6f5b6207c4bf7dc/work/f346b79201fa4640a6f5b6207c4bf7dc_id_rsa.pub 2025-09-16 22:50:29.409204 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-16 22:50:29.409225 | debian-bookworm -> localhost | SHA256:1t9qtfopiuK+pPSQd3VdPCN5G2C4dZE1oMCGoZznX9M zuul-build-sshkey 2025-09-16 22:50:29.409253 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-16 22:50:29.409271 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-16 22:50:29.409289 | debian-bookworm -> localhost | | .+. .+.o=| 2025-09-16 22:50:29.409307 | debian-bookworm -> localhost | | . o. o..o.o+.| 2025-09-16 22:50:29.409323 | debian-bookworm -> localhost | | + .. .oo.=o| 2025-09-16 22:50:29.409339 | debian-bookworm -> localhost | | o . ...o.=| 2025-09-16 22:50:29.409356 | debian-bookworm -> localhost | | .S oo.E.. | 2025-09-16 22:50:29.409377 | debian-bookworm -> localhost | | . ....o... | 2025-09-16 22:50:29.409418 | debian-bookworm -> localhost | | + o .. .... | 2025-09-16 22:50:29.409437 | debian-bookworm -> localhost | | . *.. . o... | 2025-09-16 22:50:29.409454 | debian-bookworm -> localhost | | .o=o. .oo+o | 2025-09-16 22:50:29.409471 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-16 22:50:29.409516 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.754725 2025-09-16 22:50:29.418622 | 2025-09-16 22:50:29.418705 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-16 22:50:29.466775 | debian-bookworm | ok 2025-09-16 22:50:29.484290 | debian-bookworm | included: /var/lib/zuul/builds/f346b79201fa4640a6f5b6207c4bf7dc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-16 22:50:29.495628 | 2025-09-16 22:50:29.495700 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-16 22:50:29.528799 | debian-bookworm | skipping: Conditional result was False 2025-09-16 22:50:29.540251 | 2025-09-16 22:50:29.540328 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-16 22:50:30.251183 | debian-bookworm | changed 2025-09-16 22:50:30.257355 | 2025-09-16 22:50:30.257467 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-16 22:50:30.498081 | debian-bookworm | ok 2025-09-16 22:50:30.503332 | 2025-09-16 22:50:30.503450 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-16 22:50:31.197724 | debian-bookworm | changed 2025-09-16 22:50:31.207081 | 2025-09-16 22:50:31.207186 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-16 22:50:31.867909 | debian-bookworm | changed 2025-09-16 22:50:31.873656 | 2025-09-16 22:50:31.873741 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-16 22:50:31.896567 | debian-bookworm | skipping: Conditional result was False 2025-09-16 22:50:31.902128 | 2025-09-16 22:50:31.902210 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-16 22:50:32.374285 | debian-bookworm -> localhost | changed 2025-09-16 22:50:32.396972 | 2025-09-16 22:50:32.397094 | TASK [add-build-sshkey : Add back temp key] 2025-09-16 22:50:32.775494 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f346b79201fa4640a6f5b6207c4bf7dc/work/f346b79201fa4640a6f5b6207c4bf7dc_id_rsa (zuul-build-sshkey) 2025-09-16 22:50:32.775733 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012262 2025-09-16 22:50:32.795347 | 2025-09-16 22:50:32.795472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-16 22:50:33.197533 | debian-bookworm | ok 2025-09-16 22:50:33.201777 | 2025-09-16 22:50:33.201865 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-16 22:50:33.242302 | debian-bookworm | skipping: Conditional result was False 2025-09-16 22:50:33.260603 | 2025-09-16 22:50:33.260716 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-16 22:50:33.647703 | debian-bookworm | ok 2025-09-16 22:50:33.658422 | 2025-09-16 22:50:33.658507 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-16 22:50:33.694479 | debian-bookworm | ok 2025-09-16 22:50:33.698857 | 2025-09-16 22:50:33.698937 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-16 22:50:34.067778 | debian-bookworm -> localhost | ok 2025-09-16 22:50:34.073255 | 2025-09-16 22:50:34.073340 | TASK [validate-host : Collect information about the host] 2025-09-16 22:50:35.105977 | debian-bookworm | ok 2025-09-16 22:50:35.126209 | 2025-09-16 22:50:35.126328 | TASK [validate-host : Sanitize hostname] 2025-09-16 22:50:35.216583 | debian-bookworm | ok 2025-09-16 22:50:35.259638 | 2025-09-16 22:50:35.259750 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-16 22:50:35.908473 | debian-bookworm -> localhost | changed 2025-09-16 22:50:35.914005 | 2025-09-16 22:50:35.914098 | TASK [validate-host : Collect information about zuul worker] 2025-09-16 22:50:36.345210 | debian-bookworm | ok 2025-09-16 22:50:36.349678 | 2025-09-16 22:50:36.349761 | TASK [validate-host : Write out all zuul information for each host] 2025-09-16 22:50:37.192285 | debian-bookworm -> localhost | changed 2025-09-16 22:50:37.207572 | 2025-09-16 22:50:37.207688 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-16 22:50:37.480546 | debian-bookworm | ok 2025-09-16 22:50:37.489560 | 2025-09-16 22:50:37.489828 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-16 22:50:38.825612 | debian-bookworm | changed: 2025-09-16 22:50:38.825817 | debian-bookworm | cd+++++++++ src/ 2025-09-16 22:50:38.825851 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-16 22:50:38.825875 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-16 22:50:38.825897 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-osism-ansible/ 2025-09-16 22:50:38.825917 | debian-bookworm | Containerfile 2025-09-16 22:50:38.826048 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006175 2025-09-16 22:51:04.535930 | 2025-09-16 22:51:04.536045 | TASK [upload-logs : Upload logs to log server] 2025-09-16 22:51:05.112751 | localhost | Output suppressed because no_log was given 2025-09-16 22:51:05.116020 | 2025-09-16 22:51:05.116177 | LOOP [upload-logs : Compress console log and json output] 2025-09-16 22:51:05.175197 | localhost | skipping: Conditional result was False 2025-09-16 22:51:05.181230 | localhost | skipping: Conditional result was False 2025-09-16 22:51:05.188528 | 2025-09-16 22:51:05.188812 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-16 22:51:05.238066 | localhost | skipping: Conditional result was False 2025-09-16 22:51:05.238445 | 2025-09-16 22:51:05.242870 | localhost | skipping: Conditional result was False 2025-09-16 22:51:05.249747 | 2025-09-16 22:51:05.250010 | LOOP [upload-logs : Upload console log and json output]