2025-12-16 00:18:51.838897 | Job console starting 2025-12-16 00:18:51.854715 | Updating git repos 2025-12-16 00:18:51.905820 | Cloning repos into workspace 2025-12-16 00:18:51.970550 | Restoring repo states 2025-12-16 00:18:51.981285 | Merging changes 2025-12-16 00:18:52.555503 | Checking out repos 2025-12-16 00:18:52.592017 | Preparing playbooks 2025-12-16 00:18:53.611593 | Running Ansible setup 2025-12-16 00:18:58.751218 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-16 00:18:59.780620 | 2025-12-16 00:18:59.780926 | PLAY [Base pre] 2025-12-16 00:18:59.797645 | 2025-12-16 00:18:59.797829 | TASK [Setup log path fact] 2025-12-16 00:18:59.817181 | debian-bookworm | ok 2025-12-16 00:18:59.836254 | 2025-12-16 00:18:59.836480 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-16 00:18:59.887286 | debian-bookworm | ok 2025-12-16 00:18:59.907963 | 2025-12-16 00:18:59.908104 | TASK [emit-job-header : Print job information] 2025-12-16 00:18:59.985223 | # Job Information 2025-12-16 00:18:59.985477 | Ansible Version: 2.16.14 2025-12-16 00:18:59.985514 | Job: python-black 2025-12-16 00:18:59.985557 | Pipeline: check 2025-12-16 00:18:59.985585 | Executor: 521e9411259a 2025-12-16 00:18:59.985607 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1040 2025-12-16 00:18:59.985628 | Event ID: c71ec910-da14-11f0-866b-91d02aa82ece 2025-12-16 00:18:59.991784 | 2025-12-16 00:18:59.991936 | LOOP [emit-job-header : Print node information] 2025-12-16 00:19:00.163887 | debian-bookworm | ok: 2025-12-16 00:19:00.164095 | debian-bookworm | # Node Information 2025-12-16 00:19:00.164131 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-16 00:19:00.164157 | debian-bookworm | Hostname: debian 2025-12-16 00:19:00.164179 | debian-bookworm | Username: zuul 2025-12-16 00:19:00.164201 | debian-bookworm | Distro: Debian 12.12 2025-12-16 00:19:00.164311 | debian-bookworm | Provider: regiocloud-a 2025-12-16 00:19:00.164339 | debian-bookworm | Region: 2025-12-16 00:19:00.164372 | debian-bookworm | Label: debian-bookworm 2025-12-16 00:19:00.164400 | debian-bookworm | Product Name: OpenStack Nova 2025-12-16 00:19:00.164427 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feca:d866 2025-12-16 00:19:00.179683 | 2025-12-16 00:19:00.179866 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-16 00:19:00.937244 | debian-bookworm -> localhost | changed 2025-12-16 00:19:00.945918 | 2025-12-16 00:19:00.946073 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-16 00:19:02.753133 | debian-bookworm -> localhost | changed 2025-12-16 00:19:02.787126 | 2025-12-16 00:19:02.787291 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-16 00:19:03.269446 | debian-bookworm -> localhost | ok 2025-12-16 00:19:03.276025 | 2025-12-16 00:19:03.276159 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-16 00:19:03.295743 | debian-bookworm | ok 2025-12-16 00:19:03.334008 | debian-bookworm | included: /var/lib/zuul/builds/dfd807c7c0af478eb5bc7699de112bc0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-16 00:19:03.340402 | 2025-12-16 00:19:03.340527 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-16 00:19:06.033024 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-16 00:19:06.033367 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dfd807c7c0af478eb5bc7699de112bc0/work/dfd807c7c0af478eb5bc7699de112bc0_id_rsa 2025-12-16 00:19:06.033418 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dfd807c7c0af478eb5bc7699de112bc0/work/dfd807c7c0af478eb5bc7699de112bc0_id_rsa.pub 2025-12-16 00:19:06.033448 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-16 00:19:06.033474 | debian-bookworm -> localhost | SHA256:hTQ2zsdheeKHWhY9EuFgC55jelit2iy/m34bHthRpBc zuul-build-sshkey 2025-12-16 00:19:06.033498 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-16 00:19:06.033532 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-16 00:19:06.033554 | debian-bookworm -> localhost | | . B E= | 2025-12-16 00:19:06.033576 | debian-bookworm -> localhost | | . X %=o+ | 2025-12-16 00:19:06.033597 | debian-bookworm -> localhost | | * B.B* . | 2025-12-16 00:19:06.033616 | debian-bookworm -> localhost | | = o == . | 2025-12-16 00:19:06.033636 | debian-bookworm -> localhost | | o o S+ . | 2025-12-16 00:19:06.033664 | debian-bookworm -> localhost | | = o.. | 2025-12-16 00:19:06.033686 | debian-bookworm -> localhost | | o + + | 2025-12-16 00:19:06.033706 | debian-bookworm -> localhost | | o o.o | 2025-12-16 00:19:06.033727 | debian-bookworm -> localhost | | .*+o. | 2025-12-16 00:19:06.033748 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-16 00:19:06.033842 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.811454 2025-12-16 00:19:06.044873 | 2025-12-16 00:19:06.045077 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-16 00:19:06.085104 | debian-bookworm | ok 2025-12-16 00:19:06.095884 | debian-bookworm | included: /var/lib/zuul/builds/dfd807c7c0af478eb5bc7699de112bc0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-16 00:19:06.105106 | 2025-12-16 00:19:06.105214 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-16 00:19:06.129172 | debian-bookworm | skipping: Conditional result was False 2025-12-16 00:19:06.135320 | 2025-12-16 00:19:06.135432 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-16 00:19:06.881635 | debian-bookworm | changed 2025-12-16 00:19:06.892480 | 2025-12-16 00:19:06.892658 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-16 00:19:07.156811 | debian-bookworm | ok 2025-12-16 00:19:07.163071 | 2025-12-16 00:19:07.163198 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-16 00:19:07.854255 | debian-bookworm | changed 2025-12-16 00:19:07.862998 | 2025-12-16 00:19:07.863177 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-16 00:19:08.503572 | debian-bookworm | changed 2025-12-16 00:19:08.509481 | 2025-12-16 00:19:08.509593 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-16 00:19:08.533381 | debian-bookworm | skipping: Conditional result was False 2025-12-16 00:19:08.539541 | 2025-12-16 00:19:08.539656 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-16 00:19:09.120585 | debian-bookworm -> localhost | changed 2025-12-16 00:19:09.139766 | 2025-12-16 00:19:09.139935 | TASK [add-build-sshkey : Add back temp key] 2025-12-16 00:19:09.518604 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dfd807c7c0af478eb5bc7699de112bc0/work/dfd807c7c0af478eb5bc7699de112bc0_id_rsa (zuul-build-sshkey) 2025-12-16 00:19:09.518951 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014072 2025-12-16 00:19:09.529951 | 2025-12-16 00:19:09.530089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-16 00:19:09.969621 | debian-bookworm | ok 2025-12-16 00:19:09.977288 | 2025-12-16 00:19:09.977431 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-16 00:19:10.004863 | debian-bookworm | skipping: Conditional result was False 2025-12-16 00:19:10.015930 | 2025-12-16 00:19:10.016052 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-16 00:19:10.468980 | debian-bookworm | ok 2025-12-16 00:19:10.486890 | 2025-12-16 00:19:10.487094 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-16 00:19:10.517965 | debian-bookworm | ok 2025-12-16 00:19:10.524675 | 2025-12-16 00:19:10.524856 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-16 00:19:10.883443 | debian-bookworm -> localhost | ok 2025-12-16 00:19:10.892768 | 2025-12-16 00:19:10.892914 | TASK [validate-host : Collect information about the host] 2025-12-16 00:19:12.111071 | debian-bookworm | ok 2025-12-16 00:19:12.122325 | 2025-12-16 00:19:12.122463 | TASK [validate-host : Sanitize hostname] 2025-12-16 00:19:12.243746 | debian-bookworm | ok 2025-12-16 00:19:12.348284 | 2025-12-16 00:19:12.348440 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-16 00:19:12.969912 | debian-bookworm -> localhost | changed 2025-12-16 00:19:12.978753 | 2025-12-16 00:19:12.979461 | TASK [validate-host : Collect information about zuul worker] 2025-12-16 00:19:13.427862 | debian-bookworm | ok 2025-12-16 00:19:13.441876 | 2025-12-16 00:19:13.442036 | TASK [validate-host : Write out all zuul information for each host] 2025-12-16 00:19:14.174327 | debian-bookworm -> localhost | changed 2025-12-16 00:19:14.195385 | 2025-12-16 00:19:14.195534 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-16 00:19:14.514559 | debian-bookworm | ok 2025-12-16 00:19:14.532631 | 2025-12-16 00:19:14.532780 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-16 00:19:15.709157 | debian-bookworm | changed: 2025-12-16 00:19:15.709390 | debian-bookworm | cd+++++++++ src/ 2025-12-16 00:19:15.709427 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-16 00:19:15.709453 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-16 00:19:15.709475 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-12-16 00:19:15.709496 | debian-bookworm | localhost | ok: Runtime: 0:00:00.011974 2025-12-16 00:19:41.307713 | 2025-12-16 00:19:41.308045 | TASK [upload-logs : Upload logs to log server] 2025-12-16 00:19:41.962662 | localhost | Output suppressed because no_log was given 2025-12-16 00:19:41.964708 | 2025-12-16 00:19:41.964835 | LOOP [upload-logs : Compress console log and json output] 2025-12-16 00:19:42.012909 | localhost | skipping: Conditional result was False 2025-12-16 00:19:42.019619 | localhost | skipping: Conditional result was False 2025-12-16 00:19:42.031445 | 2025-12-16 00:19:42.031585 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-16 00:19:42.086411 | localhost | skipping: Conditional result was False 2025-12-16 00:19:42.086764 | 2025-12-16 00:19:42.091967 | localhost | skipping: Conditional result was False 2025-12-16 00:19:42.102140 | 2025-12-16 00:19:42.102345 | LOOP [upload-logs : Upload console log and json output]