2026-01-12 07:15:08.637587 | Job console starting 2026-01-12 07:15:08.657352 | Updating git repos 2026-01-12 07:15:08.703057 | Cloning repos into workspace 2026-01-12 07:15:08.764759 | Restoring repo states 2026-01-12 07:15:08.769175 | Merging changes 2026-01-12 07:15:09.340388 | Checking out repos 2026-01-12 07:15:09.401000 | Preparing playbooks 2026-01-12 07:15:10.253924 | Running Ansible setup 2026-01-12 07:15:14.860708 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-12 07:15:15.672278 | 2026-01-12 07:15:15.672442 | PLAY [Base pre] 2026-01-12 07:15:15.697009 | 2026-01-12 07:15:15.697169 | TASK [Setup log path fact] 2026-01-12 07:15:15.716359 | debian-bookworm | ok 2026-01-12 07:15:15.732050 | 2026-01-12 07:15:15.732220 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-12 07:15:15.762124 | debian-bookworm | ok 2026-01-12 07:15:15.772163 | 2026-01-12 07:15:15.772302 | TASK [emit-job-header : Print job information] 2026-01-12 07:15:15.812636 | # Job Information 2026-01-12 07:15:15.812887 | Ansible Version: 2.16.14 2026-01-12 07:15:15.812926 | Job: python-black 2026-01-12 07:15:15.812958 | Pipeline: check 2026-01-12 07:15:15.812980 | Executor: 521e9411259a 2026-01-12 07:15:15.813001 | Triggered by: https://github.com/osism/testbed/pull/2820 2026-01-12 07:15:15.813023 | Event ID: 67b4be80-ef86-11f0-8784-d3e062ead0c8 2026-01-12 07:15:15.818122 | 2026-01-12 07:15:15.818245 | LOOP [emit-job-header : Print node information] 2026-01-12 07:15:15.954145 | debian-bookworm | ok: 2026-01-12 07:15:15.954341 | debian-bookworm | # Node Information 2026-01-12 07:15:15.954376 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-12 07:15:15.954400 | debian-bookworm | Hostname: debian 2026-01-12 07:15:15.954421 | debian-bookworm | Username: zuul 2026-01-12 07:15:15.954442 | debian-bookworm | Distro: Debian 12.13 2026-01-12 07:15:15.954467 | debian-bookworm | Provider: regiocloud-a 2026-01-12 07:15:15.954489 | debian-bookworm | Region: 2026-01-12 07:15:15.954510 | debian-bookworm | Label: debian-bookworm 2026-01-12 07:15:15.954529 | debian-bookworm | Product Name: OpenStack Nova 2026-01-12 07:15:15.954549 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:53fd 2026-01-12 07:15:15.966935 | 2026-01-12 07:15:15.967092 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-12 07:15:16.531552 | debian-bookworm -> localhost | changed 2026-01-12 07:15:16.542550 | 2026-01-12 07:15:16.542708 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-12 07:15:17.696912 | debian-bookworm -> localhost | changed 2026-01-12 07:15:17.708219 | 2026-01-12 07:15:17.708351 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-12 07:15:18.129105 | debian-bookworm -> localhost | ok 2026-01-12 07:15:18.143090 | 2026-01-12 07:15:18.143254 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-12 07:15:18.172136 | debian-bookworm | ok 2026-01-12 07:15:18.195088 | debian-bookworm | included: /var/lib/zuul/builds/155630002c4140e09b9673b6d98c45e3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-12 07:15:18.201419 | 2026-01-12 07:15:18.201617 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-12 07:15:19.525835 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-12 07:15:19.526163 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/155630002c4140e09b9673b6d98c45e3/work/155630002c4140e09b9673b6d98c45e3_id_rsa 2026-01-12 07:15:19.526224 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/155630002c4140e09b9673b6d98c45e3/work/155630002c4140e09b9673b6d98c45e3_id_rsa.pub 2026-01-12 07:15:19.526266 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-12 07:15:19.526305 | debian-bookworm -> localhost | SHA256:CHnD0GIHKativc5un6nabXwtMkecoS6I061Q/5SDKMY zuul-build-sshkey 2026-01-12 07:15:19.526341 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-12 07:15:19.526399 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-12 07:15:19.526436 | debian-bookworm -> localhost | | o+ | 2026-01-12 07:15:19.526471 | debian-bookworm -> localhost | | . ++o | 2026-01-12 07:15:19.526504 | debian-bookworm -> localhost | | +oo+ | 2026-01-12 07:15:19.526537 | debian-bookworm -> localhost | | . o + | 2026-01-12 07:15:19.526570 | debian-bookworm -> localhost | | .o + S | 2026-01-12 07:15:19.526612 | debian-bookworm -> localhost | |+o + o = | 2026-01-12 07:15:19.526645 | debian-bookworm -> localhost | |*Eo.* = . | 2026-01-12 07:15:19.526678 | debian-bookworm -> localhost | |++++oOo= . | 2026-01-12 07:15:19.526711 | debian-bookworm -> localhost | | o*B==* . | 2026-01-12 07:15:19.526743 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-12 07:15:19.526870 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.817361 2026-01-12 07:15:19.537253 | 2026-01-12 07:15:19.537419 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-12 07:15:19.566617 | debian-bookworm | ok 2026-01-12 07:15:19.576596 | debian-bookworm | included: /var/lib/zuul/builds/155630002c4140e09b9673b6d98c45e3/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-12 07:15:19.586617 | 2026-01-12 07:15:19.586764 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-12 07:15:19.610946 | debian-bookworm | skipping: Conditional result was False 2026-01-12 07:15:19.617411 | 2026-01-12 07:15:19.617549 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-12 07:15:20.307827 | debian-bookworm | changed 2026-01-12 07:15:20.316611 | 2026-01-12 07:15:20.316752 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-12 07:15:20.584169 | debian-bookworm | ok 2026-01-12 07:15:20.592258 | 2026-01-12 07:15:20.592396 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-12 07:15:21.275938 | debian-bookworm | changed 2026-01-12 07:15:21.284439 | 2026-01-12 07:15:21.284577 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-12 07:15:21.980479 | debian-bookworm | changed 2026-01-12 07:15:21.986685 | 2026-01-12 07:15:21.986884 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-12 07:15:22.010729 | debian-bookworm | skipping: Conditional result was False 2026-01-12 07:15:22.017903 | 2026-01-12 07:15:22.018045 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-12 07:15:22.488706 | debian-bookworm -> localhost | changed 2026-01-12 07:15:22.500394 | 2026-01-12 07:15:22.500531 | TASK [add-build-sshkey : Add back temp key] 2026-01-12 07:15:22.881974 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/155630002c4140e09b9673b6d98c45e3/work/155630002c4140e09b9673b6d98c45e3_id_rsa (zuul-build-sshkey) 2026-01-12 07:15:22.882513 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010825 2026-01-12 07:15:22.893344 | 2026-01-12 07:15:22.893480 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-12 07:15:23.314007 | debian-bookworm | ok 2026-01-12 07:15:23.321775 | 2026-01-12 07:15:23.321976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-12 07:15:23.346086 | debian-bookworm | skipping: Conditional result was False 2026-01-12 07:15:23.357277 | 2026-01-12 07:15:23.357404 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-12 07:15:23.804928 | debian-bookworm | ok 2026-01-12 07:15:23.816408 | 2026-01-12 07:15:23.816552 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-12 07:15:23.845561 | debian-bookworm | ok 2026-01-12 07:15:23.851114 | 2026-01-12 07:15:23.851242 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-12 07:15:24.291454 | debian-bookworm -> localhost | ok 2026-01-12 07:15:24.303328 | 2026-01-12 07:15:24.303530 | TASK [validate-host : Collect information about the host] 2026-01-12 07:15:25.559758 | debian-bookworm | ok 2026-01-12 07:15:25.570342 | 2026-01-12 07:15:25.570474 | TASK [validate-host : Sanitize hostname] 2026-01-12 07:15:25.683683 | debian-bookworm | ok 2026-01-12 07:15:25.735159 | 2026-01-12 07:15:25.735307 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-12 07:15:26.368356 | debian-bookworm -> localhost | changed 2026-01-12 07:15:26.374433 | 2026-01-12 07:15:26.374558 | TASK [validate-host : Collect information about zuul worker] 2026-01-12 07:15:26.762138 | debian-bookworm | ok 2026-01-12 07:15:26.767261 | 2026-01-12 07:15:26.767385 | TASK [validate-host : Write out all zuul information for each host] 2026-01-12 07:15:27.368714 | debian-bookworm -> localhost | changed 2026-01-12 07:15:27.379356 | 2026-01-12 07:15:27.379489 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-12 07:15:27.643658 | debian-bookworm | ok 2026-01-12 07:15:27.649878 | 2026-01-12 07:15:27.650010 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-12 07:15:28.840775 | debian-bookworm | changed: 2026-01-12 07:15:28.841004 | debian-bookworm | cd+++++++++ src/ 2026-01-12 07:15:28.841041 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-12 07:15:28.841066 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-12 07:15:28.841089 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-12 07:15:28.841110 | debian-bookworm | localhost | ok: Runtime: 0:00:00.018449 2026-01-12 07:15:53.946269 | 2026-01-12 07:15:53.946458 | TASK [upload-logs : Upload logs to log server] 2026-01-12 07:15:54.536364 | localhost | Output suppressed because no_log was given 2026-01-12 07:15:54.538527 | 2026-01-12 07:15:54.538645 | LOOP [upload-logs : Compress console log and json output] 2026-01-12 07:15:54.591806 | localhost | skipping: Conditional result was False 2026-01-12 07:15:54.599939 | localhost | skipping: Conditional result was False 2026-01-12 07:15:54.606392 | 2026-01-12 07:15:54.606514 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-12 07:15:54.652496 | localhost | skipping: Conditional result was False 2026-01-12 07:15:54.652847 | 2026-01-12 07:15:54.657828 | localhost | skipping: Conditional result was False 2026-01-12 07:15:54.662464 | 2026-01-12 07:15:54.662581 | LOOP [upload-logs : Upload console log and json output]