2026-01-21 21:05:08.569538 | Job console starting 2026-01-21 21:05:08.594257 | Updating git repos 2026-01-21 21:05:08.646873 | Cloning repos into workspace 2026-01-21 21:05:08.756919 | Restoring repo states 2026-01-21 21:05:08.762239 | Merging changes 2026-01-21 21:05:09.299482 | Checking out repos 2026-01-21 21:05:09.333651 | Preparing playbooks 2026-01-21 21:05:10.050479 | Running Ansible setup 2026-01-21 21:05:14.836074 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-21 21:05:15.601813 | 2026-01-21 21:05:15.601974 | PLAY [Base pre] 2026-01-21 21:05:15.617784 | 2026-01-21 21:05:15.617917 | TASK [Setup log path fact] 2026-01-21 21:05:15.637646 | debian-bookworm | ok 2026-01-21 21:05:15.654466 | 2026-01-21 21:05:15.654618 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-21 21:05:15.701289 | debian-bookworm | ok 2026-01-21 21:05:15.711069 | 2026-01-21 21:05:15.711190 | TASK [emit-job-header : Print job information] 2026-01-21 21:05:15.750486 | # Job Information 2026-01-21 21:05:15.750678 | Ansible Version: 2.16.14 2026-01-21 21:05:15.750713 | Job: python-black 2026-01-21 21:05:15.750744 | Pipeline: check 2026-01-21 21:05:15.750767 | Executor: 521e9411259a 2026-01-21 21:05:15.750788 | Triggered by: https://github.com/osism/testbed/pull/2821 2026-01-21 21:05:15.750809 | Event ID: d7ed3280-f70c-11f0-92f8-129416c6e158 2026-01-21 21:05:15.755821 | 2026-01-21 21:05:15.755940 | LOOP [emit-job-header : Print node information] 2026-01-21 21:05:15.869014 | debian-bookworm | ok: 2026-01-21 21:05:15.869215 | debian-bookworm | # Node Information 2026-01-21 21:05:15.869250 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-21 21:05:15.869275 | debian-bookworm | Hostname: debian 2026-01-21 21:05:15.869297 | debian-bookworm | Username: zuul 2026-01-21 21:05:15.869317 | debian-bookworm | Distro: Debian 12.13 2026-01-21 21:05:15.869341 | debian-bookworm | Provider: regiocloud-a 2026-01-21 21:05:15.869362 | debian-bookworm | Region: 2026-01-21 21:05:15.869383 | debian-bookworm | Label: debian-bookworm 2026-01-21 21:05:15.869455 | debian-bookworm | Product Name: OpenStack Nova 2026-01-21 21:05:15.869477 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3f:3e2a 2026-01-21 21:05:15.882819 | 2026-01-21 21:05:15.883003 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-21 21:05:16.477364 | debian-bookworm -> localhost | changed 2026-01-21 21:05:16.485896 | 2026-01-21 21:05:16.486029 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-21 21:05:17.619280 | debian-bookworm -> localhost | changed 2026-01-21 21:05:17.630376 | 2026-01-21 21:05:17.630529 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-21 21:05:17.924431 | debian-bookworm -> localhost | ok 2026-01-21 21:05:17.930705 | 2026-01-21 21:05:17.930853 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-21 21:05:17.959249 | debian-bookworm | ok 2026-01-21 21:05:17.976219 | debian-bookworm | included: /var/lib/zuul/builds/fe80a463287c4823a4045ee4de2e6b81/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-21 21:05:17.982314 | 2026-01-21 21:05:17.982460 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-21 21:05:19.543564 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-21 21:05:19.544156 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fe80a463287c4823a4045ee4de2e6b81/work/fe80a463287c4823a4045ee4de2e6b81_id_rsa 2026-01-21 21:05:19.544273 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fe80a463287c4823a4045ee4de2e6b81/work/fe80a463287c4823a4045ee4de2e6b81_id_rsa.pub 2026-01-21 21:05:19.544349 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-21 21:05:19.544480 | debian-bookworm -> localhost | SHA256:BdnT7rBnlj27Lx1ywmXGKDjLQZgqbQDwHPuixJCuTpM zuul-build-sshkey 2026-01-21 21:05:19.544548 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-21 21:05:19.544632 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-21 21:05:19.544694 | debian-bookworm -> localhost | |o.o +o . | 2026-01-21 21:05:19.544755 | debian-bookworm -> localhost | | + + o.oo . | 2026-01-21 21:05:19.544812 | debian-bookworm -> localhost | |o + o . . oo o | 2026-01-21 21:05:19.544865 | debian-bookworm -> localhost | |+ o + =.... = | 2026-01-21 21:05:19.544920 | debian-bookworm -> localhost | | +. + S ++oo+ | 2026-01-21 21:05:19.544984 | debian-bookworm -> localhost | |o... o. *+oo | 2026-01-21 21:05:19.545034 | debian-bookworm -> localhost | |oE + ++.| 2026-01-21 21:05:19.545082 | debian-bookworm -> localhost | |o . o .| 2026-01-21 21:05:19.545134 | debian-bookworm -> localhost | | . .+.| 2026-01-21 21:05:19.545185 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-21 21:05:19.545312 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.067729 2026-01-21 21:05:19.556534 | 2026-01-21 21:05:19.556671 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-21 21:05:19.598994 | debian-bookworm | ok 2026-01-21 21:05:19.610540 | debian-bookworm | included: /var/lib/zuul/builds/fe80a463287c4823a4045ee4de2e6b81/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-21 21:05:19.619651 | 2026-01-21 21:05:19.619763 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-21 21:05:19.643618 | debian-bookworm | skipping: Conditional result was False 2026-01-21 21:05:19.649571 | 2026-01-21 21:05:19.649683 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-21 21:05:20.300630 | debian-bookworm | changed 2026-01-21 21:05:20.310914 | 2026-01-21 21:05:20.311071 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-21 21:05:20.583528 | debian-bookworm | ok 2026-01-21 21:05:20.590314 | 2026-01-21 21:05:20.590484 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-21 21:05:21.237040 | debian-bookworm | changed 2026-01-21 21:05:21.244500 | 2026-01-21 21:05:21.244629 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-21 21:05:21.811325 | debian-bookworm | changed 2026-01-21 21:05:21.817873 | 2026-01-21 21:05:21.817989 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-21 21:05:21.841686 | debian-bookworm | skipping: Conditional result was False 2026-01-21 21:05:21.847978 | 2026-01-21 21:05:21.848100 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-21 21:05:22.320862 | debian-bookworm -> localhost | changed 2026-01-21 21:05:22.333091 | 2026-01-21 21:05:22.333216 | TASK [add-build-sshkey : Add back temp key] 2026-01-21 21:05:22.692793 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fe80a463287c4823a4045ee4de2e6b81/work/fe80a463287c4823a4045ee4de2e6b81_id_rsa (zuul-build-sshkey) 2026-01-21 21:05:22.693125 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011356 2026-01-21 21:05:22.702633 | 2026-01-21 21:05:22.702766 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-21 21:05:23.116090 | debian-bookworm | ok 2026-01-21 21:05:23.121314 | 2026-01-21 21:05:23.121438 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-21 21:05:23.145154 | debian-bookworm | skipping: Conditional result was False 2026-01-21 21:05:23.155492 | 2026-01-21 21:05:23.155605 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-21 21:05:23.603928 | debian-bookworm | ok 2026-01-21 21:05:23.619046 | 2026-01-21 21:05:23.619192 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-21 21:05:23.658437 | debian-bookworm | ok 2026-01-21 21:05:23.663714 | 2026-01-21 21:05:23.663836 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-21 21:05:23.964956 | debian-bookworm -> localhost | ok 2026-01-21 21:05:23.971673 | 2026-01-21 21:05:23.971796 | TASK [validate-host : Collect information about the host] 2026-01-21 21:05:25.075995 | debian-bookworm | ok 2026-01-21 21:05:25.086927 | 2026-01-21 21:05:25.087063 | TASK [validate-host : Sanitize hostname] 2026-01-21 21:05:25.268875 | debian-bookworm | ok 2026-01-21 21:05:25.339692 | 2026-01-21 21:05:25.339964 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-21 21:05:25.990974 | debian-bookworm -> localhost | changed 2026-01-21 21:05:25.996996 | 2026-01-21 21:05:25.997117 | TASK [validate-host : Collect information about zuul worker] 2026-01-21 21:05:26.437385 | debian-bookworm | ok 2026-01-21 21:05:26.445434 | 2026-01-21 21:05:26.445590 | TASK [validate-host : Write out all zuul information for each host] 2026-01-21 21:05:26.995690 | debian-bookworm -> localhost | changed 2026-01-21 21:05:27.005636 | 2026-01-21 21:05:27.005750 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-21 21:05:27.271555 | debian-bookworm | ok 2026-01-21 21:05:27.280823 | 2026-01-21 21:05:27.280966 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-21 21:05:28.548799 | debian-bookworm | changed: 2026-01-21 21:05:28.549192 | debian-bookworm | cd+++++++++ src/ 2026-01-21 21:05:28.549246 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-21 21:05:28.549278 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-21 21:05:28.549310 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2026-01-21 21:05:28.549337 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005573 2026-01-21 21:05:53.062378 | 2026-01-21 21:05:53.062516 | TASK [upload-logs : Upload logs to log server] 2026-01-21 21:05:53.579970 | localhost | Output suppressed because no_log was given 2026-01-21 21:05:53.583244 | 2026-01-21 21:05:53.583387 | LOOP [upload-logs : Compress console log and json output] 2026-01-21 21:05:53.637520 | localhost | skipping: Conditional result was False 2026-01-21 21:05:53.646235 | localhost | skipping: Conditional result was False 2026-01-21 21:05:53.651923 | 2026-01-21 21:05:53.652015 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-21 21:05:53.699432 | localhost | skipping: Conditional result was False 2026-01-21 21:05:53.699683 | 2026-01-21 21:05:53.705814 | localhost | skipping: Conditional result was False 2026-01-21 21:05:53.717853 | 2026-01-21 21:05:53.717958 | LOOP [upload-logs : Upload console log and json output]