2026-01-29 18:32:22.358460 | Job console starting 2026-01-29 18:32:22.377925 | Updating git repos 2026-01-29 18:32:22.422100 | Cloning repos into workspace 2026-01-29 18:32:22.480175 | Restoring repo states 2026-01-29 18:32:22.484795 | Merging changes 2026-01-29 18:32:22.991331 | Checking out repos 2026-01-29 18:32:23.043108 | Preparing playbooks 2026-01-29 18:32:23.780627 | Running Ansible setup 2026-01-29 18:32:28.090707 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 18:32:29.030217 | 2026-01-29 18:32:29.030396 | PLAY [Base pre] 2026-01-29 18:32:29.053433 | 2026-01-29 18:32:29.053593 | TASK [Setup log path fact] 2026-01-29 18:32:29.082926 | debian-bookworm | ok 2026-01-29 18:32:29.098175 | 2026-01-29 18:32:29.098379 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 18:32:29.129094 | debian-bookworm | ok 2026-01-29 18:32:29.139036 | 2026-01-29 18:32:29.139166 | TASK [emit-job-header : Print job information] 2026-01-29 18:32:29.178520 | # Job Information 2026-01-29 18:32:29.178705 | Ansible Version: 2.16.14 2026-01-29 18:32:29.178742 | Job: python-black 2026-01-29 18:32:29.178776 | Pipeline: check 2026-01-29 18:32:29.178798 | Executor: 521e9411259a 2026-01-29 18:32:29.178819 | Triggered by: https://github.com/osism/testbed/pull/2841 2026-01-29 18:32:29.178876 | Event ID: d4bbb110-fd40-11f0-8a2c-797d3210f604 2026-01-29 18:32:29.183903 | 2026-01-29 18:32:29.184026 | LOOP [emit-job-header : Print node information] 2026-01-29 18:32:29.291338 | debian-bookworm | ok: 2026-01-29 18:32:29.291623 | debian-bookworm | # Node Information 2026-01-29 18:32:29.291662 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 18:32:29.291688 | debian-bookworm | Hostname: debian 2026-01-29 18:32:29.291710 | debian-bookworm | Username: zuul 2026-01-29 18:32:29.291730 | debian-bookworm | Distro: Debian 12.13 2026-01-29 18:32:29.291754 | debian-bookworm | Provider: regiocloud-a 2026-01-29 18:32:29.291775 | debian-bookworm | Region: 2026-01-29 18:32:29.291796 | debian-bookworm | Label: debian-bookworm 2026-01-29 18:32:29.291815 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 18:32:29.291834 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe47:1a22 2026-01-29 18:32:29.309987 | 2026-01-29 18:32:29.310120 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 18:32:29.780259 | debian-bookworm -> localhost | changed 2026-01-29 18:32:29.787770 | 2026-01-29 18:32:29.787907 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 18:32:31.005240 | debian-bookworm -> localhost | changed 2026-01-29 18:32:31.017624 | 2026-01-29 18:32:31.017762 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 18:32:31.355939 | debian-bookworm -> localhost | ok 2026-01-29 18:32:31.362395 | 2026-01-29 18:32:31.362521 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 18:32:31.399817 | debian-bookworm | ok 2026-01-29 18:32:31.431336 | debian-bookworm | included: /var/lib/zuul/builds/8b94c1f036b543408d962039195a9d66/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 18:32:31.448760 | 2026-01-29 18:32:31.448886 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 18:32:32.947056 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 18:32:32.947785 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8b94c1f036b543408d962039195a9d66/work/8b94c1f036b543408d962039195a9d66_id_rsa 2026-01-29 18:32:32.947942 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8b94c1f036b543408d962039195a9d66/work/8b94c1f036b543408d962039195a9d66_id_rsa.pub 2026-01-29 18:32:32.948054 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 18:32:32.948156 | debian-bookworm -> localhost | SHA256:OdmQ3BZiLWMz9Tt8/Vhf1xmWCoH+gfjNuVNQu4NyT2c zuul-build-sshkey 2026-01-29 18:32:32.948255 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 18:32:32.948466 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 18:32:32.948564 | debian-bookworm -> localhost | | oo+. | 2026-01-29 18:32:32.948657 | debian-bookworm -> localhost | | o*=.o.. .| 2026-01-29 18:32:32.948746 | debian-bookworm -> localhost | | .*=+.o .+ | 2026-01-29 18:32:32.948831 | debian-bookworm -> localhost | | . O +.oo.+| 2026-01-29 18:32:32.948911 | debian-bookworm -> localhost | | S = O.o.*| 2026-01-29 18:32:32.949006 | debian-bookworm -> localhost | | + B B E=| 2026-01-29 18:32:32.949086 | debian-bookworm -> localhost | | o = = o| 2026-01-29 18:32:32.949164 | debian-bookworm -> localhost | | o . | 2026-01-29 18:32:32.949240 | debian-bookworm -> localhost | | . | 2026-01-29 18:32:32.949343 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 18:32:32.949501 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.967522 2026-01-29 18:32:32.962345 | 2026-01-29 18:32:32.962515 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 18:32:32.992972 | debian-bookworm | ok 2026-01-29 18:32:33.002457 | debian-bookworm | included: /var/lib/zuul/builds/8b94c1f036b543408d962039195a9d66/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 18:32:33.011393 | 2026-01-29 18:32:33.011499 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 18:32:33.035095 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:32:33.044386 | 2026-01-29 18:32:33.044511 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 18:32:33.700912 | debian-bookworm | changed 2026-01-29 18:32:33.711824 | 2026-01-29 18:32:33.711983 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 18:32:33.985446 | debian-bookworm | ok 2026-01-29 18:32:33.997234 | 2026-01-29 18:32:33.997404 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 18:32:34.699863 | debian-bookworm | changed 2026-01-29 18:32:34.707178 | 2026-01-29 18:32:34.707290 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 18:32:35.342960 | debian-bookworm | changed 2026-01-29 18:32:35.348599 | 2026-01-29 18:32:35.348705 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 18:32:35.372284 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:32:35.378339 | 2026-01-29 18:32:35.378452 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 18:32:35.857994 | debian-bookworm -> localhost | changed 2026-01-29 18:32:35.869643 | 2026-01-29 18:32:35.869771 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 18:32:36.229224 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8b94c1f036b543408d962039195a9d66/work/8b94c1f036b543408d962039195a9d66_id_rsa (zuul-build-sshkey) 2026-01-29 18:32:36.229492 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018182 2026-01-29 18:32:36.244996 | 2026-01-29 18:32:36.245196 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 18:32:36.661145 | debian-bookworm | ok 2026-01-29 18:32:36.666268 | 2026-01-29 18:32:36.666423 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 18:32:36.695352 | debian-bookworm | skipping: Conditional result was False 2026-01-29 18:32:36.706271 | 2026-01-29 18:32:36.706420 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 18:32:37.155348 | debian-bookworm | ok 2026-01-29 18:32:37.169337 | 2026-01-29 18:32:37.169461 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 18:32:37.200815 | debian-bookworm | ok 2026-01-29 18:32:37.207658 | 2026-01-29 18:32:37.207783 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 18:32:37.490042 | debian-bookworm -> localhost | ok 2026-01-29 18:32:37.496610 | 2026-01-29 18:32:37.496720 | TASK [validate-host : Collect information about the host] 2026-01-29 18:32:38.637005 | debian-bookworm | ok 2026-01-29 18:32:38.647205 | 2026-01-29 18:32:38.647357 | TASK [validate-host : Sanitize hostname] 2026-01-29 18:32:38.767925 | debian-bookworm | ok 2026-01-29 18:32:38.809502 | 2026-01-29 18:32:38.809645 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 18:32:39.361062 | debian-bookworm -> localhost | changed 2026-01-29 18:32:39.367367 | 2026-01-29 18:32:39.367493 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 18:32:39.782233 | debian-bookworm | ok 2026-01-29 18:32:39.787348 | 2026-01-29 18:32:39.787473 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 18:32:40.377842 | debian-bookworm -> localhost | changed 2026-01-29 18:32:40.387640 | 2026-01-29 18:32:40.387754 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 18:32:40.663064 | debian-bookworm | ok 2026-01-29 18:32:40.671391 | 2026-01-29 18:32:40.671535 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 18:32:41.880037 | debian-bookworm | changed: 2026-01-29 18:32:41.880259 | debian-bookworm | cd+++++++++ src/ 2026-01-29 18:32:41.880314 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 18:32:41.880340 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 18:32:41.880362 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-29 18:32:41.880382 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006105 2026-01-29 18:33:06.941009 | 2026-01-29 18:33:06.941131 | TASK [upload-logs : Upload logs to log server] 2026-01-29 18:33:07.587170 | localhost | Output suppressed because no_log was given 2026-01-29 18:33:07.589179 | 2026-01-29 18:33:07.589313 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 18:33:07.641150 | localhost | skipping: Conditional result was False 2026-01-29 18:33:07.647282 | localhost | skipping: Conditional result was False 2026-01-29 18:33:07.657449 | 2026-01-29 18:33:07.657558 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 18:33:07.708869 | localhost | skipping: Conditional result was False 2026-01-29 18:33:07.709222 | 2026-01-29 18:33:07.713561 | localhost | skipping: Conditional result was False 2026-01-29 18:33:07.730543 | 2026-01-29 18:33:07.730669 | LOOP [upload-logs : Upload console log and json output]