2025-12-02 20:53:31.022431 | Job console starting 2025-12-02 20:53:31.078051 | Updating git repos 2025-12-02 20:53:31.204629 | Cloning repos into workspace 2025-12-02 20:53:31.325729 | Restoring repo states 2025-12-02 20:53:31.366265 | Merging changes 2025-12-02 20:53:32.085281 | Checking out repos 2025-12-02 20:53:32.132896 | Preparing playbooks 2025-12-02 20:53:33.296219 | Running Ansible setup 2025-12-02 20:53:40.246349 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 20:53:41.343209 | 2025-12-02 20:53:41.343406 | PLAY [Base pre] 2025-12-02 20:53:41.369882 | 2025-12-02 20:53:41.370059 | TASK [Setup log path fact] 2025-12-02 20:53:41.400471 | debian-bookworm | ok 2025-12-02 20:53:41.429563 | 2025-12-02 20:53:41.429740 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 20:53:41.491728 | debian-bookworm | ok 2025-12-02 20:53:41.513171 | 2025-12-02 20:53:41.513306 | TASK [emit-job-header : Print job information] 2025-12-02 20:53:41.583130 | # Job Information 2025-12-02 20:53:41.583329 | Ansible Version: 2.16.14 2025-12-02 20:53:41.583364 | Job: python-black 2025-12-02 20:53:41.583435 | Pipeline: check 2025-12-02 20:53:41.583460 | Executor: 521e9411259a 2025-12-02 20:53:41.583481 | Triggered by: https://github.com/osism/python-osism/pull/1875 2025-12-02 20:53:41.583504 | Event ID: f04a7f90-cfc0-11f0-95af-7abdbc465219 2025-12-02 20:53:41.589301 | 2025-12-02 20:53:41.589433 | LOOP [emit-job-header : Print node information] 2025-12-02 20:53:41.899274 | debian-bookworm | ok: 2025-12-02 20:53:41.903006 | debian-bookworm | # Node Information 2025-12-02 20:53:41.903113 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 20:53:41.903145 | debian-bookworm | Hostname: debian 2025-12-02 20:53:41.903170 | debian-bookworm | Username: zuul 2025-12-02 20:53:41.903192 | debian-bookworm | Distro: Debian 12.12 2025-12-02 20:53:41.903216 | debian-bookworm | Provider: regiocloud-a 2025-12-02 20:53:41.903238 | debian-bookworm | Region: 2025-12-02 20:53:41.903259 | debian-bookworm | Label: debian-bookworm 2025-12-02 20:53:41.903279 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 20:53:41.903299 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6e:5e72 2025-12-02 20:53:41.920906 | 2025-12-02 20:53:41.921045 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 20:53:42.706039 | debian-bookworm -> localhost | changed 2025-12-02 20:53:42.713978 | 2025-12-02 20:53:42.714114 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 20:53:44.578272 | debian-bookworm -> localhost | changed 2025-12-02 20:53:44.586733 | 2025-12-02 20:53:44.586826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 20:53:45.140369 | debian-bookworm -> localhost | ok 2025-12-02 20:53:45.146751 | 2025-12-02 20:53:45.146885 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 20:53:45.185094 | debian-bookworm | ok 2025-12-02 20:53:45.215482 | debian-bookworm | included: /var/lib/zuul/builds/876e8e720a9f467b8fd85b5dc8718516/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 20:53:45.221310 | 2025-12-02 20:53:45.221420 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 20:53:46.711823 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 20:53:46.712192 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/876e8e720a9f467b8fd85b5dc8718516/work/876e8e720a9f467b8fd85b5dc8718516_id_rsa 2025-12-02 20:53:46.712255 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/876e8e720a9f467b8fd85b5dc8718516/work/876e8e720a9f467b8fd85b5dc8718516_id_rsa.pub 2025-12-02 20:53:46.712297 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 20:53:46.712337 | debian-bookworm -> localhost | SHA256:RfjA1lGoBGu2HzDt6zoI1oXyroqDXqicP3HYaYyYppk zuul-build-sshkey 2025-12-02 20:53:46.712388 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 20:53:46.712443 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 20:53:46.712495 | debian-bookworm -> localhost | | .o oo+. | 2025-12-02 20:53:46.712536 | debian-bookworm -> localhost | | o*.o | 2025-12-02 20:53:46.712572 | debian-bookworm -> localhost | | .*o.+. | 2025-12-02 20:53:46.712608 | debian-bookworm -> localhost | | . .o.=... | 2025-12-02 20:53:46.712646 | debian-bookworm -> localhost | | o+=.o S | 2025-12-02 20:53:46.712689 | debian-bookworm -> localhost | | +++o* . o | 2025-12-02 20:53:46.712732 | debian-bookworm -> localhost | |+= ++. o | 2025-12-02 20:53:46.712772 | debian-bookworm -> localhost | |E o.o .. | 2025-12-02 20:53:46.712812 | debian-bookworm -> localhost | |=*oo. .o. | 2025-12-02 20:53:46.712853 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 20:53:46.712942 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.649087 2025-12-02 20:53:46.727500 | 2025-12-02 20:53:46.727602 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 20:53:46.769530 | debian-bookworm | ok 2025-12-02 20:53:46.790946 | debian-bookworm | included: /var/lib/zuul/builds/876e8e720a9f467b8fd85b5dc8718516/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 20:53:46.814597 | 2025-12-02 20:53:46.814695 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 20:53:46.852281 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:53:46.857394 | 2025-12-02 20:53:46.857491 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 20:53:47.543977 | debian-bookworm | changed 2025-12-02 20:53:47.553624 | 2025-12-02 20:53:47.553766 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 20:53:47.856824 | debian-bookworm | ok 2025-12-02 20:53:47.862732 | 2025-12-02 20:53:47.862888 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 20:53:48.468563 | debian-bookworm | changed 2025-12-02 20:53:48.475196 | 2025-12-02 20:53:48.475290 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 20:53:49.115720 | debian-bookworm | changed 2025-12-02 20:53:49.121742 | 2025-12-02 20:53:49.121841 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 20:53:49.144856 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:53:49.150724 | 2025-12-02 20:53:49.150820 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 20:53:49.662721 | debian-bookworm -> localhost | changed 2025-12-02 20:53:49.673797 | 2025-12-02 20:53:49.673930 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 20:53:50.245121 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/876e8e720a9f467b8fd85b5dc8718516/work/876e8e720a9f467b8fd85b5dc8718516_id_rsa (zuul-build-sshkey) 2025-12-02 20:53:50.245408 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.012226 2025-12-02 20:53:50.253853 | 2025-12-02 20:53:50.253987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 20:53:50.838618 | debian-bookworm | ok 2025-12-02 20:53:50.846751 | 2025-12-02 20:53:50.846937 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 20:53:50.872511 | debian-bookworm | skipping: Conditional result was False 2025-12-02 20:53:50.891869 | 2025-12-02 20:53:50.892036 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 20:53:51.497231 | debian-bookworm | ok 2025-12-02 20:53:51.511887 | 2025-12-02 20:53:51.512746 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 20:53:51.542244 | debian-bookworm | ok 2025-12-02 20:53:51.547927 | 2025-12-02 20:53:51.548082 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 20:53:52.113637 | debian-bookworm -> localhost | ok 2025-12-02 20:53:52.120338 | 2025-12-02 20:53:52.120495 | TASK [validate-host : Collect information about the host] 2025-12-02 20:53:53.488911 | debian-bookworm | ok 2025-12-02 20:53:53.509240 | 2025-12-02 20:53:53.509393 | TASK [validate-host : Sanitize hostname] 2025-12-02 20:53:53.693107 | debian-bookworm | ok 2025-12-02 20:53:53.816501 | 2025-12-02 20:53:53.816659 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 20:53:54.561911 | debian-bookworm -> localhost | changed 2025-12-02 20:53:54.569135 | 2025-12-02 20:53:54.569262 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 20:53:55.078415 | debian-bookworm | ok 2025-12-02 20:53:55.084166 | 2025-12-02 20:53:55.084309 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 20:53:55.842483 | debian-bookworm -> localhost | changed 2025-12-02 20:53:55.852728 | 2025-12-02 20:53:55.852860 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 20:53:56.177607 | debian-bookworm | ok 2025-12-02 20:53:56.188485 | 2025-12-02 20:53:56.188633 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 20:53:57.510368 | debian-bookworm | changed: 2025-12-02 20:53:57.510618 | debian-bookworm | cd+++++++++ src/ 2025-12-02 20:53:57.510654 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 20:53:57.510678 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 20:53:57.510700 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 20:53:57.510720 | debian-bookworm | Containerfile 2025-12-02 20:53:57.510873 | debian-bookworm | Containerfile 2025-12-02 20:53:57.558550 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006690 2025-12-02 20:54:24.914562 | 2025-12-02 20:54:24.914676 | TASK [upload-logs : Upload logs to log server] 2025-12-02 20:54:25.530735 | localhost | Output suppressed because no_log was given 2025-12-02 20:54:25.533553 | 2025-12-02 20:54:25.533715 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 20:54:25.595986 | localhost | skipping: Conditional result was False 2025-12-02 20:54:25.601421 | localhost | skipping: Conditional result was False 2025-12-02 20:54:25.616261 | 2025-12-02 20:54:25.616594 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 20:54:25.672856 | localhost | skipping: Conditional result was False 2025-12-02 20:54:25.673486 | 2025-12-02 20:54:25.677579 | localhost | skipping: Conditional result was False 2025-12-02 20:54:25.691332 | 2025-12-02 20:54:25.691616 | LOOP [upload-logs : Upload console log and json output]