2025-06-22 18:43:20.090498 | Job console starting 2025-06-22 18:43:20.107698 | Updating git repos 2025-06-22 18:43:20.140038 | Cloning repos into workspace 2025-06-22 18:43:20.200572 | Restoring repo states 2025-06-22 18:43:20.216187 | Merging changes 2025-06-22 18:43:20.701077 | Checking out repos 2025-06-22 18:43:20.756716 | Preparing playbooks 2025-06-22 18:43:21.344903 | Running Ansible setup 2025-06-22 18:43:25.812224 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-22 18:43:26.528232 | 2025-06-22 18:43:26.528414 | PLAY [Base pre] 2025-06-22 18:43:26.542712 | 2025-06-22 18:43:26.542817 | TASK [Setup log path fact] 2025-06-22 18:43:26.571021 | debian-bookworm | ok 2025-06-22 18:43:26.587152 | 2025-06-22 18:43:26.587277 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-22 18:43:26.615708 | debian-bookworm | ok 2025-06-22 18:43:26.627192 | 2025-06-22 18:43:26.627295 | TASK [emit-job-header : Print job information] 2025-06-22 18:43:26.678397 | # Job Information 2025-06-22 18:43:26.678597 | Ansible Version: 2.16.14 2025-06-22 18:43:26.678640 | Job: python-black 2025-06-22 18:43:26.678675 | Pipeline: check 2025-06-22 18:43:26.678700 | Executor: 521e9411259a 2025-06-22 18:43:26.678721 | Triggered by: https://github.com/osism/testbed/pull/2732 2025-06-22 18:43:26.678743 | Event ID: bf884ed0-4f98-11f0-8a96-6485b504b082 2025-06-22 18:43:26.683471 | 2025-06-22 18:43:26.683561 | LOOP [emit-job-header : Print node information] 2025-06-22 18:43:26.825270 | debian-bookworm | ok: 2025-06-22 18:43:26.825431 | debian-bookworm | # Node Information 2025-06-22 18:43:26.825467 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-22 18:43:26.825494 | debian-bookworm | Hostname: debian 2025-06-22 18:43:26.825518 | debian-bookworm | Username: zuul 2025-06-22 18:43:26.825539 | debian-bookworm | Distro: Debian 12.11 2025-06-22 18:43:26.825563 | debian-bookworm | Provider: regiocloud-a 2025-06-22 18:43:26.825584 | debian-bookworm | Region: 2025-06-22 18:43:26.825605 | debian-bookworm | Label: debian-bookworm 2025-06-22 18:43:26.825626 | debian-bookworm | Product Name: OpenStack Nova 2025-06-22 18:43:26.825646 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feb6:d858 2025-06-22 18:43:26.845014 | 2025-06-22 18:43:26.845116 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-22 18:43:27.293895 | debian-bookworm -> localhost | changed 2025-06-22 18:43:27.303294 | 2025-06-22 18:43:27.303407 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-22 18:43:28.298078 | debian-bookworm -> localhost | changed 2025-06-22 18:43:28.319713 | 2025-06-22 18:43:28.319850 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-22 18:43:28.576535 | debian-bookworm -> localhost | ok 2025-06-22 18:43:28.582349 | 2025-06-22 18:43:28.582453 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-22 18:43:28.600997 | debian-bookworm | ok 2025-06-22 18:43:28.619461 | debian-bookworm | included: /var/lib/zuul/builds/ff8efd90168c4408a0503201ac4e2229/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-22 18:43:28.625224 | 2025-06-22 18:43:28.625316 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-22 18:43:31.395629 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-22 18:43:31.395902 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ff8efd90168c4408a0503201ac4e2229/work/ff8efd90168c4408a0503201ac4e2229_id_rsa 2025-06-22 18:43:31.395946 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ff8efd90168c4408a0503201ac4e2229/work/ff8efd90168c4408a0503201ac4e2229_id_rsa.pub 2025-06-22 18:43:31.395973 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-22 18:43:31.395999 | debian-bookworm -> localhost | SHA256:hS2tGP1V5XeunGf63WU7RGtYB+BPakcL2EDapkIDNvM zuul-build-sshkey 2025-06-22 18:43:31.396021 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-22 18:43:31.396058 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-22 18:43:31.396080 | debian-bookworm -> localhost | | = .o .....| 2025-06-22 18:43:31.396102 | debian-bookworm -> localhost | | . = . * = ... | 2025-06-22 18:43:31.396122 | debian-bookworm -> localhost | | E = B = o.+| 2025-06-22 18:43:31.396159 | debian-bookworm -> localhost | | . + B . * =+| 2025-06-22 18:43:31.396181 | debian-bookworm -> localhost | | o S . o B +| 2025-06-22 18:43:31.396206 | debian-bookworm -> localhost | | . . + * | 2025-06-22 18:43:31.396226 | debian-bookworm -> localhost | | * =| 2025-06-22 18:43:31.396246 | debian-bookworm -> localhost | | *=| 2025-06-22 18:43:31.396267 | debian-bookworm -> localhost | | .o=| 2025-06-22 18:43:31.396287 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-22 18:43:31.396347 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.225540 2025-06-22 18:43:31.403283 | 2025-06-22 18:43:31.403406 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-22 18:43:31.436801 | debian-bookworm | ok 2025-06-22 18:43:31.451912 | debian-bookworm | included: /var/lib/zuul/builds/ff8efd90168c4408a0503201ac4e2229/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-22 18:43:31.472793 | 2025-06-22 18:43:31.472953 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-22 18:43:31.497970 | debian-bookworm | skipping: Conditional result was False 2025-06-22 18:43:31.506430 | 2025-06-22 18:43:31.506575 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-22 18:43:32.145638 | debian-bookworm | changed 2025-06-22 18:43:32.155456 | 2025-06-22 18:43:32.155595 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-22 18:43:32.420466 | debian-bookworm | ok 2025-06-22 18:43:32.426139 | 2025-06-22 18:43:32.426293 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-22 18:43:33.104158 | debian-bookworm | changed 2025-06-22 18:43:33.113097 | 2025-06-22 18:43:33.113259 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-22 18:43:33.843815 | debian-bookworm | changed 2025-06-22 18:43:33.873188 | 2025-06-22 18:43:33.873332 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-22 18:43:33.897380 | debian-bookworm | skipping: Conditional result was False 2025-06-22 18:43:33.903737 | 2025-06-22 18:43:33.903860 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-22 18:43:34.731170 | debian-bookworm -> localhost | changed 2025-06-22 18:43:34.747571 | 2025-06-22 18:43:34.747774 | TASK [add-build-sshkey : Add back temp key] 2025-06-22 18:43:35.177021 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ff8efd90168c4408a0503201ac4e2229/work/ff8efd90168c4408a0503201ac4e2229_id_rsa (zuul-build-sshkey) 2025-06-22 18:43:35.177411 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010993 2025-06-22 18:43:35.188280 | 2025-06-22 18:43:35.188417 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-22 18:43:35.602992 | debian-bookworm | ok 2025-06-22 18:43:35.614073 | 2025-06-22 18:43:35.614273 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-22 18:43:35.640406 | debian-bookworm | skipping: Conditional result was False 2025-06-22 18:43:35.663713 | 2025-06-22 18:43:35.663969 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-22 18:43:36.121717 | debian-bookworm | ok 2025-06-22 18:43:36.133471 | 2025-06-22 18:43:36.133599 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-22 18:43:36.219249 | debian-bookworm | ok 2025-06-22 18:43:36.224483 | 2025-06-22 18:43:36.224595 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-22 18:43:36.745618 | debian-bookworm -> localhost | ok 2025-06-22 18:43:36.752516 | 2025-06-22 18:43:36.752638 | TASK [validate-host : Collect information about the host] 2025-06-22 18:43:38.055960 | debian-bookworm | ok 2025-06-22 18:43:38.066987 | 2025-06-22 18:43:38.067135 | TASK [validate-host : Sanitize hostname] 2025-06-22 18:43:38.209064 | debian-bookworm | ok 2025-06-22 18:43:38.258419 | 2025-06-22 18:43:38.258563 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-22 18:43:38.943634 | debian-bookworm -> localhost | changed 2025-06-22 18:43:38.956558 | 2025-06-22 18:43:38.956813 | TASK [validate-host : Collect information about zuul worker] 2025-06-22 18:43:39.479051 | debian-bookworm | ok 2025-06-22 18:43:39.489173 | 2025-06-22 18:43:39.489322 | TASK [validate-host : Write out all zuul information for each host] 2025-06-22 18:43:40.500455 | debian-bookworm -> localhost | changed 2025-06-22 18:43:40.509489 | 2025-06-22 18:43:40.509594 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-22 18:43:40.830517 | debian-bookworm | ok 2025-06-22 18:43:40.836584 | 2025-06-22 18:43:40.836683 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-22 18:43:42.074596 | debian-bookworm | changed: 2025-06-22 18:43:42.074886 | debian-bookworm | cd+++++++++ src/ 2025-06-22 18:43:42.074940 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-22 18:43:42.074969 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-22 18:43:42.074993 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-06-22 18:43:42.075015 | debian-bookworm | localhost | ok: Runtime: 0:00:00.009070 2025-06-22 18:44:06.889339 | 2025-06-22 18:44:06.889499 | TASK [upload-logs : Upload logs to log server] 2025-06-22 18:44:07.499304 | localhost | Output suppressed because no_log was given 2025-06-22 18:44:07.503530 | 2025-06-22 18:44:07.503741 | LOOP [upload-logs : Compress console log and json output] 2025-06-22 18:44:07.564963 | localhost | skipping: Conditional result was False 2025-06-22 18:44:07.569518 | localhost | skipping: Conditional result was False 2025-06-22 18:44:07.585502 | 2025-06-22 18:44:07.585715 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-22 18:44:07.633994 | localhost | skipping: Conditional result was False 2025-06-22 18:44:07.634735 | 2025-06-22 18:44:07.638484 | localhost | skipping: Conditional result was False 2025-06-22 18:44:07.651121 | 2025-06-22 18:44:07.651345 | LOOP [upload-logs : Upload console log and json output]