2026-01-29 13:41:53.479045 | Job console starting 2026-01-29 13:41:53.514471 | Updating git repos 2026-01-29 13:41:53.557325 | Cloning repos into workspace 2026-01-29 13:41:53.636138 | Restoring repo states 2026-01-29 13:41:53.642706 | Merging changes 2026-01-29 13:41:54.214411 | Checking out repos 2026-01-29 13:41:54.277101 | Preparing playbooks 2026-01-29 13:41:54.989353 | Running Ansible setup 2026-01-29 13:42:00.236998 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 13:42:01.016224 | 2026-01-29 13:42:01.016403 | PLAY [Base pre] 2026-01-29 13:42:01.033751 | 2026-01-29 13:42:01.033920 | TASK [Setup log path fact] 2026-01-29 13:42:01.055140 | debian-bookworm | ok 2026-01-29 13:42:01.074932 | 2026-01-29 13:42:01.075105 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 13:42:01.105584 | debian-bookworm | ok 2026-01-29 13:42:01.116363 | 2026-01-29 13:42:01.116487 | TASK [emit-job-header : Print job information] 2026-01-29 13:42:01.169705 | # Job Information 2026-01-29 13:42:01.169908 | Ansible Version: 2.16.14 2026-01-29 13:42:01.169946 | Job: python-black 2026-01-29 13:42:01.169980 | Pipeline: check 2026-01-29 13:42:01.170003 | Executor: 521e9411259a 2026-01-29 13:42:01.170024 | Triggered by: https://github.com/osism/testbed/pull/2833 2026-01-29 13:42:01.170047 | Event ID: 3fb27db0-fd18-11f0-8b3f-c163c34c62e1 2026-01-29 13:42:01.176427 | 2026-01-29 13:42:01.176558 | LOOP [emit-job-header : Print node information] 2026-01-29 13:42:01.331619 | debian-bookworm | ok: 2026-01-29 13:42:01.331833 | debian-bookworm | # Node Information 2026-01-29 13:42:01.331874 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 13:42:01.331900 | debian-bookworm | Hostname: debian 2026-01-29 13:42:01.331922 | debian-bookworm | Username: zuul 2026-01-29 13:42:01.331943 | debian-bookworm | Distro: Debian 12.13 2026-01-29 13:42:01.331968 | debian-bookworm | Provider: regiocloud-a 2026-01-29 13:42:01.331990 | debian-bookworm | Region: 2026-01-29 13:42:01.332012 | debian-bookworm | Label: debian-bookworm 2026-01-29 13:42:01.332033 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 13:42:01.332053 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe06:be8 2026-01-29 13:42:01.350233 | 2026-01-29 13:42:01.350373 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 13:42:01.853256 | debian-bookworm -> localhost | changed 2026-01-29 13:42:01.862761 | 2026-01-29 13:42:01.862951 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 13:42:03.110757 | debian-bookworm -> localhost | changed 2026-01-29 13:42:03.122219 | 2026-01-29 13:42:03.122354 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 13:42:03.496404 | debian-bookworm -> localhost | ok 2026-01-29 13:42:03.503218 | 2026-01-29 13:42:03.503357 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 13:42:03.533058 | debian-bookworm | ok 2026-01-29 13:42:03.554153 | debian-bookworm | included: /var/lib/zuul/builds/b861b9e55d3c46f0a309685959bb8955/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 13:42:03.572741 | 2026-01-29 13:42:03.572912 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 13:42:07.084296 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 13:42:07.085070 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b861b9e55d3c46f0a309685959bb8955/work/b861b9e55d3c46f0a309685959bb8955_id_rsa 2026-01-29 13:42:07.085218 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b861b9e55d3c46f0a309685959bb8955/work/b861b9e55d3c46f0a309685959bb8955_id_rsa.pub 2026-01-29 13:42:07.085309 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 13:42:07.085385 | debian-bookworm -> localhost | SHA256:F1q5jOpFeR6rHXi0JpZ59ooo382t4Okchvn4op7vwgE zuul-build-sshkey 2026-01-29 13:42:07.085457 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 13:42:07.085550 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 13:42:07.085620 | debian-bookworm -> localhost | | | 2026-01-29 13:42:07.085691 | debian-bookworm -> localhost | | . | 2026-01-29 13:42:07.085758 | debian-bookworm -> localhost | | + | 2026-01-29 13:42:07.085820 | debian-bookworm -> localhost | | E * o | 2026-01-29 13:42:07.085909 | debian-bookworm -> localhost | | . S B | 2026-01-29 13:42:07.085992 | debian-bookworm -> localhost | | . = O + | 2026-01-29 13:42:07.086053 | debian-bookworm -> localhost | | . .+ @ X | 2026-01-29 13:42:07.086113 | debian-bookworm -> localhost | | +o.@ / + | 2026-01-29 13:42:07.086174 | debian-bookworm -> localhost | | .+BB+@ *oo | 2026-01-29 13:42:07.086237 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 13:42:07.086379 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.980739 2026-01-29 13:42:07.098722 | 2026-01-29 13:42:07.098920 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 13:42:07.131732 | debian-bookworm | ok 2026-01-29 13:42:07.157916 | debian-bookworm | included: /var/lib/zuul/builds/b861b9e55d3c46f0a309685959bb8955/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 13:42:07.170945 | 2026-01-29 13:42:07.171077 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 13:42:07.205103 | debian-bookworm | skipping: Conditional result was False 2026-01-29 13:42:07.211650 | 2026-01-29 13:42:07.211774 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 13:42:07.901215 | debian-bookworm | changed 2026-01-29 13:42:07.906723 | 2026-01-29 13:42:07.906934 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 13:42:08.157960 | debian-bookworm | ok 2026-01-29 13:42:08.164164 | 2026-01-29 13:42:08.164289 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 13:42:08.794578 | debian-bookworm | changed 2026-01-29 13:42:08.801711 | 2026-01-29 13:42:08.801824 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 13:42:09.428059 | debian-bookworm | changed 2026-01-29 13:42:09.433711 | 2026-01-29 13:42:09.433848 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 13:42:09.461344 | debian-bookworm | skipping: Conditional result was False 2026-01-29 13:42:09.468195 | 2026-01-29 13:42:09.468333 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 13:42:09.967625 | debian-bookworm -> localhost | changed 2026-01-29 13:42:09.987740 | 2026-01-29 13:42:09.987885 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 13:42:10.310023 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b861b9e55d3c46f0a309685959bb8955/work/b861b9e55d3c46f0a309685959bb8955_id_rsa (zuul-build-sshkey) 2026-01-29 13:42:10.310628 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019710 2026-01-29 13:42:10.325643 | 2026-01-29 13:42:10.325777 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 13:42:10.768525 | debian-bookworm | ok 2026-01-29 13:42:10.781818 | 2026-01-29 13:42:10.781957 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 13:42:10.806316 | debian-bookworm | skipping: Conditional result was False 2026-01-29 13:42:10.818915 | 2026-01-29 13:42:10.819051 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 13:42:11.258574 | debian-bookworm | ok 2026-01-29 13:42:11.272915 | 2026-01-29 13:42:11.273072 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 13:42:11.316497 | debian-bookworm | ok 2026-01-29 13:42:11.324709 | 2026-01-29 13:42:11.324876 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 13:42:11.659308 | debian-bookworm -> localhost | ok 2026-01-29 13:42:11.665893 | 2026-01-29 13:42:11.666015 | TASK [validate-host : Collect information about the host] 2026-01-29 13:42:12.794909 | debian-bookworm | ok 2026-01-29 13:42:12.806271 | 2026-01-29 13:42:12.806396 | TASK [validate-host : Sanitize hostname] 2026-01-29 13:42:12.938290 | debian-bookworm | ok 2026-01-29 13:42:12.985199 | 2026-01-29 13:42:12.985345 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 13:42:13.571498 | debian-bookworm -> localhost | changed 2026-01-29 13:42:13.581621 | 2026-01-29 13:42:13.581774 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 13:42:14.027195 | debian-bookworm | ok 2026-01-29 13:42:14.032363 | 2026-01-29 13:42:14.032491 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 13:42:14.645878 | debian-bookworm -> localhost | changed 2026-01-29 13:42:14.656347 | 2026-01-29 13:42:14.656466 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 13:42:14.935363 | debian-bookworm | ok 2026-01-29 13:42:14.941275 | 2026-01-29 13:42:14.941387 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 13:42:16.178396 | debian-bookworm | changed: 2026-01-29 13:42:16.178619 | debian-bookworm | cd+++++++++ src/ 2026-01-29 13:42:16.178656 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 13:42:16.178681 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 13:42:16.178703 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-29 13:42:16.178724 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005559 2026-01-29 13:42:42.306761 | 2026-01-29 13:42:42.307023 | TASK [upload-logs : Upload logs to log server] 2026-01-29 13:42:42.856624 | localhost | Output suppressed because no_log was given 2026-01-29 13:42:42.860799 | 2026-01-29 13:42:42.861003 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 13:42:42.915163 | localhost | skipping: Conditional result was False 2026-01-29 13:42:42.920169 | localhost | skipping: Conditional result was False 2026-01-29 13:42:42.932840 | 2026-01-29 13:42:42.933110 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 13:42:42.979698 | localhost | skipping: Conditional result was False 2026-01-29 13:42:42.980169 | 2026-01-29 13:42:42.984369 | localhost | skipping: Conditional result was False 2026-01-29 13:42:42.997049 | 2026-01-29 13:42:42.997312 | LOOP [upload-logs : Upload console log and json output]