2025-11-11 02:15:31.894141 | Job console starting 2025-11-11 02:15:31.907869 | Updating git repos 2025-11-11 02:15:31.938363 | Cloning repos into workspace 2025-11-11 02:15:32.034163 | Restoring repo states 2025-11-11 02:15:32.047718 | Merging changes 2025-11-11 02:15:32.545334 | Checking out repos 2025-11-11 02:15:32.626278 | Preparing playbooks 2025-11-11 02:15:33.440348 | Running Ansible setup 2025-11-11 02:15:38.535490 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-11 02:15:40.550891 | 2025-11-11 02:15:40.551023 | PLAY [Base pre] 2025-11-11 02:15:40.581705 | 2025-11-11 02:15:40.581862 | TASK [Setup log path fact] 2025-11-11 02:15:40.612834 | debian-bookworm | ok 2025-11-11 02:15:40.639581 | 2025-11-11 02:15:40.639712 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-11 02:15:40.691747 | debian-bookworm | ok 2025-11-11 02:15:40.717597 | 2025-11-11 02:15:40.717713 | TASK [emit-job-header : Print job information] 2025-11-11 02:15:40.776376 | # Job Information 2025-11-11 02:15:40.776536 | Ansible Version: 2.16.14 2025-11-11 02:15:40.776582 | Job: python-black 2025-11-11 02:15:40.776615 | Pipeline: check 2025-11-11 02:15:40.776638 | Executor: 521e9411259a 2025-11-11 02:15:40.776659 | Triggered by: https://github.com/osism/testbed/pull/2783 2025-11-11 02:15:40.776682 | Event ID: 48167270-bea4-11f0-9e48-ef300c4f6f9f 2025-11-11 02:15:40.781381 | 2025-11-11 02:15:40.781473 | LOOP [emit-job-header : Print node information] 2025-11-11 02:15:40.992035 | debian-bookworm | ok: 2025-11-11 02:15:40.992240 | debian-bookworm | # Node Information 2025-11-11 02:15:40.992276 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-11 02:15:40.992302 | debian-bookworm | Hostname: debian 2025-11-11 02:15:40.992324 | debian-bookworm | Username: zuul 2025-11-11 02:15:40.992346 | debian-bookworm | Distro: Debian 12.12 2025-11-11 02:15:40.992369 | debian-bookworm | Provider: regiocloud-a 2025-11-11 02:15:40.992391 | debian-bookworm | Region: 2025-11-11 02:15:40.992412 | debian-bookworm | Label: debian-bookworm 2025-11-11 02:15:40.992431 | debian-bookworm | Product Name: OpenStack Nova 2025-11-11 02:15:40.992451 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe5d:5de 2025-11-11 02:15:41.021833 | 2025-11-11 02:15:41.021943 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-11 02:15:41.604829 | debian-bookworm -> localhost | changed 2025-11-11 02:15:41.611381 | 2025-11-11 02:15:41.611484 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-11 02:15:43.271700 | debian-bookworm -> localhost | changed 2025-11-11 02:15:43.281000 | 2025-11-11 02:15:43.281086 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-11 02:15:43.960239 | debian-bookworm -> localhost | ok 2025-11-11 02:15:43.965452 | 2025-11-11 02:15:43.965535 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-11 02:15:44.002110 | debian-bookworm | ok 2025-11-11 02:15:44.027983 | debian-bookworm | included: /var/lib/zuul/builds/64f14a0a8c8e4b809879d7b479ca2ce1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-11 02:15:44.051374 | 2025-11-11 02:15:44.051467 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-11 02:15:46.833572 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-11 02:15:46.833750 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/64f14a0a8c8e4b809879d7b479ca2ce1/work/64f14a0a8c8e4b809879d7b479ca2ce1_id_rsa 2025-11-11 02:15:46.833783 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/64f14a0a8c8e4b809879d7b479ca2ce1/work/64f14a0a8c8e4b809879d7b479ca2ce1_id_rsa.pub 2025-11-11 02:15:46.833806 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-11 02:15:46.833827 | debian-bookworm -> localhost | SHA256:mFRUGrn+VKKIORpUR2FZNm5fTAhOfj8NPJqBAEMSjDU zuul-build-sshkey 2025-11-11 02:15:46.833845 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-11 02:15:46.833873 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-11 02:15:46.833891 | debian-bookworm -> localhost | | +Eo+o==X+... | 2025-11-11 02:15:46.833909 | debian-bookworm -> localhost | |. .o.ooO.=.+ | 2025-11-11 02:15:46.833925 | debian-bookworm -> localhost | | . .. B.o * | 2025-11-11 02:15:46.833941 | debian-bookworm -> localhost | | . . +.o.*.+ | 2025-11-11 02:15:46.833958 | debian-bookworm -> localhost | | . oooS.+oo . | 2025-11-11 02:15:46.833980 | debian-bookworm -> localhost | | . + . o . . | 2025-11-11 02:15:46.833997 | debian-bookworm -> localhost | | o . o | 2025-11-11 02:15:46.834013 | debian-bookworm -> localhost | | . . | 2025-11-11 02:15:46.834030 | debian-bookworm -> localhost | | | 2025-11-11 02:15:46.834046 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-11 02:15:46.834090 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.869404 2025-11-11 02:15:46.839288 | 2025-11-11 02:15:46.839370 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-11 02:15:46.865592 | debian-bookworm | ok 2025-11-11 02:15:46.872974 | debian-bookworm | included: /var/lib/zuul/builds/64f14a0a8c8e4b809879d7b479ca2ce1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-11 02:15:46.898764 | 2025-11-11 02:15:46.898874 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-11 02:15:46.931549 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:46.936228 | 2025-11-11 02:15:46.936308 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-11 02:15:47.637634 | debian-bookworm | changed 2025-11-11 02:15:47.656996 | 2025-11-11 02:15:47.657087 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-11 02:15:47.973791 | debian-bookworm | ok 2025-11-11 02:15:47.978395 | 2025-11-11 02:15:47.978491 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-11 02:15:48.829349 | debian-bookworm | changed 2025-11-11 02:15:48.834747 | 2025-11-11 02:15:48.834823 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-11 02:15:49.608212 | debian-bookworm | changed 2025-11-11 02:15:49.612813 | 2025-11-11 02:15:49.612892 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-11 02:15:49.655604 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:49.660389 | 2025-11-11 02:15:49.660472 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-11 02:15:50.638197 | debian-bookworm -> localhost | changed 2025-11-11 02:15:50.647079 | 2025-11-11 02:15:50.647175 | TASK [add-build-sshkey : Add back temp key] 2025-11-11 02:15:51.559269 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/64f14a0a8c8e4b809879d7b479ca2ce1/work/64f14a0a8c8e4b809879d7b479ca2ce1_id_rsa (zuul-build-sshkey) 2025-11-11 02:15:51.559524 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.037986 2025-11-11 02:15:51.569712 | 2025-11-11 02:15:51.569825 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-11 02:15:52.092194 | debian-bookworm | ok 2025-11-11 02:15:52.096227 | 2025-11-11 02:15:52.096305 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-11 02:15:52.138977 | debian-bookworm | skipping: Conditional result was False 2025-11-11 02:15:52.147126 | 2025-11-11 02:15:52.147209 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-11 02:15:52.815576 | debian-bookworm | ok 2025-11-11 02:15:52.823990 | 2025-11-11 02:15:52.824076 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-11 02:15:52.861862 | debian-bookworm | ok 2025-11-11 02:15:52.865871 | 2025-11-11 02:15:52.865944 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-11 02:15:53.350627 | debian-bookworm -> localhost | ok 2025-11-11 02:15:53.355894 | 2025-11-11 02:15:53.355983 | TASK [validate-host : Collect information about the host] 2025-11-11 02:15:54.711454 | debian-bookworm | ok 2025-11-11 02:15:54.721576 | 2025-11-11 02:15:54.721663 | TASK [validate-host : Sanitize hostname] 2025-11-11 02:15:54.928827 | debian-bookworm | ok 2025-11-11 02:15:54.990127 | 2025-11-11 02:15:54.990228 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-11 02:15:55.844506 | debian-bookworm -> localhost | changed 2025-11-11 02:15:55.849000 | 2025-11-11 02:15:55.849078 | TASK [validate-host : Collect information about zuul worker] 2025-11-11 02:15:56.421236 | debian-bookworm | ok 2025-11-11 02:15:56.431439 | 2025-11-11 02:15:56.431529 | TASK [validate-host : Write out all zuul information for each host] 2025-11-11 02:15:57.687845 | debian-bookworm -> localhost | changed 2025-11-11 02:15:57.695701 | 2025-11-11 02:15:57.695787 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-11 02:15:58.005372 | debian-bookworm | ok 2025-11-11 02:15:58.009919 | 2025-11-11 02:15:58.009996 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-11 02:15:59.437451 | debian-bookworm | changed: 2025-11-11 02:15:59.437603 | debian-bookworm | cd+++++++++ src/ 2025-11-11 02:15:59.437632 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-11 02:15:59.437653 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-11 02:15:59.437670 | debian-bookworm | cd+++++++++ src/github.com/osism/testbed/ 2025-11-11 02:15:59.437687 | debian-bookworm | localhost | ok: Runtime: 0:00:00.020782 2025-11-11 02:16:25.993057 | 2025-11-11 02:16:25.993180 | TASK [upload-logs : Upload logs to log server] 2025-11-11 02:16:27.158409 | localhost | Output suppressed because no_log was given 2025-11-11 02:16:27.159955 | 2025-11-11 02:16:27.160027 | LOOP [upload-logs : Compress console log and json output] 2025-11-11 02:16:27.223611 | localhost | skipping: Conditional result was False 2025-11-11 02:16:27.231014 | localhost | skipping: Conditional result was False 2025-11-11 02:16:27.235835 | 2025-11-11 02:16:27.235924 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-11 02:16:27.317336 | localhost | skipping: Conditional result was False 2025-11-11 02:16:27.317589 | 2025-11-11 02:16:27.330385 | localhost | skipping: Conditional result was False 2025-11-11 02:16:27.342474 | 2025-11-11 02:16:27.342596 | LOOP [upload-logs : Upload console log and json output]