2025-09-11 14:49:42.893748 | Job console starting 2025-09-11 14:49:42.941321 | Updating git repos 2025-09-11 14:49:42.995808 | Cloning repos into workspace 2025-09-11 14:49:43.061821 | Restoring repo states 2025-09-11 14:49:43.083138 | Merging changes 2025-09-11 14:49:43.910586 | Checking out repos 2025-09-11 14:49:43.981279 | Preparing playbooks 2025-09-11 14:49:44.956319 | Running Ansible setup 2025-09-11 14:49:49.788204 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-11 14:49:50.838297 | 2025-09-11 14:49:50.838474 | PLAY [Base pre] 2025-09-11 14:49:50.855116 | 2025-09-11 14:49:50.855259 | TASK [Setup log path fact] 2025-09-11 14:49:50.874031 | debian-bookworm | ok 2025-09-11 14:49:50.889384 | 2025-09-11 14:49:50.889581 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-11 14:49:50.919292 | debian-bookworm | ok 2025-09-11 14:49:50.929302 | 2025-09-11 14:49:50.929423 | TASK [emit-job-header : Print job information] 2025-09-11 14:49:50.978644 | # Job Information 2025-09-11 14:49:50.978857 | Ansible Version: 2.16.14 2025-09-11 14:49:50.978898 | Job: python-black 2025-09-11 14:49:50.978932 | Pipeline: check 2025-09-11 14:49:50.978955 | Executor: 521e9411259a 2025-09-11 14:49:50.978975 | Triggered by: https://github.com/osism/openstack-image-manager/pull/957 2025-09-11 14:49:50.978997 | Event ID: 87641780-8f1e-11f0-9943-8123e2b23a82 2025-09-11 14:49:50.983989 | 2025-09-11 14:49:50.984098 | LOOP [emit-job-header : Print node information] 2025-09-11 14:49:51.093729 | debian-bookworm | ok: 2025-09-11 14:49:51.094016 | debian-bookworm | # Node Information 2025-09-11 14:49:51.094056 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-11 14:49:51.094082 | debian-bookworm | Hostname: debian 2025-09-11 14:49:51.094105 | debian-bookworm | Username: zuul 2025-09-11 14:49:51.094125 | debian-bookworm | Distro: Debian 12.12 2025-09-11 14:49:51.094148 | debian-bookworm | Provider: regiocloud-a 2025-09-11 14:49:51.094169 | debian-bookworm | Region: 2025-09-11 14:49:51.094189 | debian-bookworm | Label: debian-bookworm 2025-09-11 14:49:51.094208 | debian-bookworm | Product Name: OpenStack Nova 2025-09-11 14:49:51.094228 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecc:1c07 2025-09-11 14:49:51.114768 | 2025-09-11 14:49:51.114937 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-11 14:49:51.855792 | debian-bookworm -> localhost | changed 2025-09-11 14:49:51.863801 | 2025-09-11 14:49:51.864079 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-11 14:49:53.421936 | debian-bookworm -> localhost | changed 2025-09-11 14:49:53.431958 | 2025-09-11 14:49:53.432054 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-11 14:49:53.761061 | debian-bookworm -> localhost | ok 2025-09-11 14:49:53.766796 | 2025-09-11 14:49:53.766911 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-11 14:49:53.783971 | debian-bookworm | ok 2025-09-11 14:49:53.806505 | debian-bookworm | included: /var/lib/zuul/builds/f04c05aa78ef404582ca61ef17e3a6bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-11 14:49:53.812834 | 2025-09-11 14:49:53.812919 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-11 14:49:55.101110 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-11 14:49:55.101355 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f04c05aa78ef404582ca61ef17e3a6bc/work/f04c05aa78ef404582ca61ef17e3a6bc_id_rsa 2025-09-11 14:49:55.101398 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f04c05aa78ef404582ca61ef17e3a6bc/work/f04c05aa78ef404582ca61ef17e3a6bc_id_rsa.pub 2025-09-11 14:49:55.101427 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-11 14:49:55.101452 | debian-bookworm -> localhost | SHA256:IbRfqF/gCPRvvHSQWZYHjJxvaciOjtlEyUEMy1moYDE zuul-build-sshkey 2025-09-11 14:49:55.101474 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-11 14:49:55.101534 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-11 14:49:55.101558 | debian-bookworm -> localhost | | E. o=+. ++o | 2025-09-11 14:49:55.101580 | debian-bookworm -> localhost | |...o.*o.+*o . | 2025-09-11 14:49:55.101600 | debian-bookworm -> localhost | |.. .=.++Bo.o | 2025-09-11 14:49:55.101620 | debian-bookworm -> localhost | | . .+Oo== | 2025-09-11 14:49:55.101640 | debian-bookworm -> localhost | | .ooSoo | 2025-09-11 14:49:55.101666 | debian-bookworm -> localhost | | o+.+ | 2025-09-11 14:49:55.101687 | debian-bookworm -> localhost | | * o | 2025-09-11 14:49:55.101707 | debian-bookworm -> localhost | | o o | 2025-09-11 14:49:55.101728 | debian-bookworm -> localhost | | | 2025-09-11 14:49:55.101748 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-11 14:49:55.101799 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.801765 2025-09-11 14:49:55.107735 | 2025-09-11 14:49:55.107821 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-11 14:49:55.144804 | debian-bookworm | ok 2025-09-11 14:49:55.162636 | debian-bookworm | included: /var/lib/zuul/builds/f04c05aa78ef404582ca61ef17e3a6bc/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-11 14:49:55.180262 | 2025-09-11 14:49:55.180341 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-11 14:49:55.202970 | debian-bookworm | skipping: Conditional result was False 2025-09-11 14:49:55.208367 | 2025-09-11 14:49:55.208451 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-11 14:49:55.812368 | debian-bookworm | changed 2025-09-11 14:49:55.816583 | 2025-09-11 14:49:55.816651 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-11 14:49:56.084447 | debian-bookworm | ok 2025-09-11 14:49:56.088783 | 2025-09-11 14:49:56.088855 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-11 14:49:56.720623 | debian-bookworm | changed 2025-09-11 14:49:56.728198 | 2025-09-11 14:49:56.728291 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-11 14:49:57.339815 | debian-bookworm | changed 2025-09-11 14:49:57.349316 | 2025-09-11 14:49:57.349426 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-11 14:49:57.372518 | debian-bookworm | skipping: Conditional result was False 2025-09-11 14:49:57.380108 | 2025-09-11 14:49:57.380215 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-11 14:49:57.791373 | debian-bookworm -> localhost | changed 2025-09-11 14:49:57.801608 | 2025-09-11 14:49:57.801707 | TASK [add-build-sshkey : Add back temp key] 2025-09-11 14:49:58.079797 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f04c05aa78ef404582ca61ef17e3a6bc/work/f04c05aa78ef404582ca61ef17e3a6bc_id_rsa (zuul-build-sshkey) 2025-09-11 14:49:58.080015 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015151 2025-09-11 14:49:58.087432 | 2025-09-11 14:49:58.087540 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-11 14:49:58.490715 | debian-bookworm | ok 2025-09-11 14:49:58.524859 | 2025-09-11 14:49:58.525247 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-11 14:49:58.564198 | debian-bookworm | skipping: Conditional result was False 2025-09-11 14:49:58.593049 | 2025-09-11 14:49:58.593135 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-11 14:49:59.110180 | debian-bookworm | ok 2025-09-11 14:49:59.120875 | 2025-09-11 14:49:59.120979 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-11 14:49:59.148933 | debian-bookworm | ok 2025-09-11 14:49:59.153751 | 2025-09-11 14:49:59.153849 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-11 14:49:59.519649 | debian-bookworm -> localhost | ok 2025-09-11 14:49:59.525652 | 2025-09-11 14:49:59.525743 | TASK [validate-host : Collect information about the host] 2025-09-11 14:50:00.639515 | debian-bookworm | ok 2025-09-11 14:50:00.660162 | 2025-09-11 14:50:00.660300 | TASK [validate-host : Sanitize hostname] 2025-09-11 14:50:00.793105 | debian-bookworm | ok 2025-09-11 14:50:00.839651 | 2025-09-11 14:50:00.839792 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-11 14:50:01.501255 | debian-bookworm -> localhost | changed 2025-09-11 14:50:01.507267 | 2025-09-11 14:50:01.507402 | TASK [validate-host : Collect information about zuul worker] 2025-09-11 14:50:01.949748 | debian-bookworm | ok 2025-09-11 14:50:01.954818 | 2025-09-11 14:50:01.954998 | TASK [validate-host : Write out all zuul information for each host] 2025-09-11 14:50:02.732075 | debian-bookworm -> localhost | changed 2025-09-11 14:50:02.742168 | 2025-09-11 14:50:02.742341 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-11 14:50:03.066583 | debian-bookworm | ok 2025-09-11 14:50:03.072442 | 2025-09-11 14:50:03.072584 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-11 14:50:04.094530 | debian-bookworm | changed: 2025-09-11 14:50:04.096568 | debian-bookworm | cd+++++++++ src/ 2025-09-11 14:50:04.096634 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-11 14:50:04.096659 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-11 14:50:04.096754 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-09-11 14:50:04.096776 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004007 2025-09-11 14:50:29.089955 | 2025-09-11 14:50:29.090076 | TASK [upload-logs : Upload logs to log server] 2025-09-11 14:50:29.670976 | localhost | Output suppressed because no_log was given 2025-09-11 14:50:29.672845 | 2025-09-11 14:50:29.672949 | LOOP [upload-logs : Compress console log and json output] 2025-09-11 14:50:29.720736 | localhost | skipping: Conditional result was False 2025-09-11 14:50:29.726775 | localhost | skipping: Conditional result was False 2025-09-11 14:50:29.730136 | 2025-09-11 14:50:29.730246 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-11 14:50:29.798439 | localhost | skipping: Conditional result was False 2025-09-11 14:50:29.798785 | 2025-09-11 14:50:29.803437 | localhost | skipping: Conditional result was False 2025-09-11 14:50:29.807773 | 2025-09-11 14:50:29.807906 | LOOP [upload-logs : Upload console log and json output]