2025-09-09 20:27:54.023935 | Job console starting 2025-09-09 20:27:54.045374 | Updating git repos 2025-09-09 20:27:54.073418 | Cloning repos into workspace 2025-09-09 20:27:54.136784 | Restoring repo states 2025-09-09 20:27:54.146329 | Merging changes 2025-09-09 20:27:54.747673 | Checking out repos 2025-09-09 20:27:54.791971 | Preparing playbooks 2025-09-09 20:27:55.584926 | Running Ansible setup 2025-09-09 20:28:00.099775 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-09 20:28:00.836993 | 2025-09-09 20:28:00.837205 | PLAY [Base pre] 2025-09-09 20:28:00.853866 | 2025-09-09 20:28:00.853995 | TASK [Setup log path fact] 2025-09-09 20:28:00.873050 | debian-bookworm | ok 2025-09-09 20:28:00.887999 | 2025-09-09 20:28:00.888131 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-09 20:28:00.917810 | debian-bookworm | ok 2025-09-09 20:28:00.928103 | 2025-09-09 20:28:00.928215 | TASK [emit-job-header : Print job information] 2025-09-09 20:28:00.967545 | # Job Information 2025-09-09 20:28:00.967716 | Ansible Version: 2.16.14 2025-09-09 20:28:00.967750 | Job: python-black 2025-09-09 20:28:00.967782 | Pipeline: check 2025-09-09 20:28:00.967804 | Executor: 521e9411259a 2025-09-09 20:28:00.967825 | Triggered by: https://github.com/osism/zuul-jobs/pull/169 2025-09-09 20:28:00.967849 | Event ID: 7074a9e0-8dbb-11f0-87dc-038e3c7a9f55 2025-09-09 20:28:00.972722 | 2025-09-09 20:28:00.972838 | LOOP [emit-job-header : Print node information] 2025-09-09 20:28:01.106283 | debian-bookworm | ok: 2025-09-09 20:28:01.106595 | debian-bookworm | # Node Information 2025-09-09 20:28:01.106655 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-09 20:28:01.106697 | debian-bookworm | Hostname: debian 2025-09-09 20:28:01.106733 | debian-bookworm | Username: zuul 2025-09-09 20:28:01.106766 | debian-bookworm | Distro: Debian 12.12 2025-09-09 20:28:01.106807 | debian-bookworm | Provider: regiocloud-a 2025-09-09 20:28:01.106875 | debian-bookworm | Region: 2025-09-09 20:28:01.106911 | debian-bookworm | Label: debian-bookworm 2025-09-09 20:28:01.106944 | debian-bookworm | Product Name: OpenStack Nova 2025-09-09 20:28:01.106973 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea2:60e4 2025-09-09 20:28:01.143117 | 2025-09-09 20:28:01.143269 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-09 20:28:01.745042 | debian-bookworm -> localhost | changed 2025-09-09 20:28:01.752427 | 2025-09-09 20:28:01.752544 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-09 20:28:02.883916 | debian-bookworm -> localhost | changed 2025-09-09 20:28:02.899309 | 2025-09-09 20:28:02.899454 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-09 20:28:03.196455 | debian-bookworm -> localhost | ok 2025-09-09 20:28:03.202738 | 2025-09-09 20:28:03.202888 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-09 20:28:03.231514 | debian-bookworm | ok 2025-09-09 20:28:03.249705 | debian-bookworm | included: /var/lib/zuul/builds/e42f61eb568a4d67bba9f5bf418726ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-09 20:28:03.255914 | 2025-09-09 20:28:03.256014 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-09 20:28:04.443757 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-09 20:28:04.444004 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e42f61eb568a4d67bba9f5bf418726ba/work/e42f61eb568a4d67bba9f5bf418726ba_id_rsa 2025-09-09 20:28:04.444045 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e42f61eb568a4d67bba9f5bf418726ba/work/e42f61eb568a4d67bba9f5bf418726ba_id_rsa.pub 2025-09-09 20:28:04.444072 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-09 20:28:04.444098 | debian-bookworm -> localhost | SHA256:uEm5oAiiPmN2ByYzfU7nsMq/c71nSGT4ML34Rgrz8Ec zuul-build-sshkey 2025-09-09 20:28:04.444121 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-09 20:28:04.444158 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-09 20:28:04.444180 | debian-bookworm -> localhost | | | 2025-09-09 20:28:04.444202 | debian-bookworm -> localhost | | | 2025-09-09 20:28:04.444223 | debian-bookworm -> localhost | | o | 2025-09-09 20:28:04.444243 | debian-bookworm -> localhost | | * + | 2025-09-09 20:28:04.444263 | debian-bookworm -> localhost | |o . . + S . | 2025-09-09 20:28:04.444292 | debian-bookworm -> localhost | |+= = X * E | 2025-09-09 20:28:04.444313 | debian-bookworm -> localhost | |o * = # B . | 2025-09-09 20:28:04.444333 | debian-bookworm -> localhost | |.=.. = * * o | 2025-09-09 20:28:04.444354 | debian-bookworm -> localhost | |o.+o+o+ o.+ | 2025-09-09 20:28:04.444374 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-09 20:28:04.444446 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.706635 2025-09-09 20:28:04.451401 | 2025-09-09 20:28:04.451537 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-09 20:28:04.483235 | debian-bookworm | ok 2025-09-09 20:28:04.493341 | debian-bookworm | included: /var/lib/zuul/builds/e42f61eb568a4d67bba9f5bf418726ba/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-09 20:28:04.502447 | 2025-09-09 20:28:04.502555 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-09 20:28:04.526159 | debian-bookworm | skipping: Conditional result was False 2025-09-09 20:28:04.532007 | 2025-09-09 20:28:04.532119 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-09 20:28:05.207635 | debian-bookworm | changed 2025-09-09 20:28:05.213145 | 2025-09-09 20:28:05.213256 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-09 20:28:05.481371 | debian-bookworm | ok 2025-09-09 20:28:05.492165 | 2025-09-09 20:28:05.492321 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-09 20:28:06.182298 | debian-bookworm | changed 2025-09-09 20:28:06.195332 | 2025-09-09 20:28:06.195608 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-09 20:28:06.897710 | debian-bookworm | changed 2025-09-09 20:28:06.909490 | 2025-09-09 20:28:06.909637 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-09 20:28:06.935840 | debian-bookworm | skipping: Conditional result was False 2025-09-09 20:28:06.944945 | 2025-09-09 20:28:06.945261 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-09 20:28:07.405955 | debian-bookworm -> localhost | changed 2025-09-09 20:28:07.417478 | 2025-09-09 20:28:07.417613 | TASK [add-build-sshkey : Add back temp key] 2025-09-09 20:28:07.775336 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e42f61eb568a4d67bba9f5bf418726ba/work/e42f61eb568a4d67bba9f5bf418726ba_id_rsa (zuul-build-sshkey) 2025-09-09 20:28:07.775638 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010787 2025-09-09 20:28:07.784359 | 2025-09-09 20:28:07.784519 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-09 20:28:08.253315 | debian-bookworm | ok 2025-09-09 20:28:08.260495 | 2025-09-09 20:28:08.260627 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-09 20:28:08.306813 | debian-bookworm | skipping: Conditional result was False 2025-09-09 20:28:08.324519 | 2025-09-09 20:28:08.324689 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-09 20:28:08.814426 | debian-bookworm | ok 2025-09-09 20:28:08.832438 | 2025-09-09 20:28:08.832728 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-09 20:28:08.878418 | debian-bookworm | ok 2025-09-09 20:28:08.888093 | 2025-09-09 20:28:08.888420 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-09 20:28:09.338597 | debian-bookworm -> localhost | ok 2025-09-09 20:28:09.349134 | 2025-09-09 20:28:09.349260 | TASK [validate-host : Collect information about the host] 2025-09-09 20:28:10.501917 | debian-bookworm | ok 2025-09-09 20:28:10.516225 | 2025-09-09 20:28:10.516356 | TASK [validate-host : Sanitize hostname] 2025-09-09 20:28:10.627701 | debian-bookworm | ok 2025-09-09 20:28:10.677170 | 2025-09-09 20:28:10.677306 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-09 20:28:11.374149 | debian-bookworm -> localhost | changed 2025-09-09 20:28:11.381001 | 2025-09-09 20:28:11.381137 | TASK [validate-host : Collect information about zuul worker] 2025-09-09 20:28:11.858226 | debian-bookworm | ok 2025-09-09 20:28:11.863582 | 2025-09-09 20:28:11.863723 | TASK [validate-host : Write out all zuul information for each host] 2025-09-09 20:28:12.438004 | debian-bookworm -> localhost | changed 2025-09-09 20:28:12.455326 | 2025-09-09 20:28:12.455510 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-09 20:28:12.812893 | debian-bookworm | ok 2025-09-09 20:28:12.836582 | 2025-09-09 20:28:12.837929 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-09 20:28:13.853528 | debian-bookworm | changed: 2025-09-09 20:28:13.853797 | debian-bookworm | cd+++++++++ src/ 2025-09-09 20:28:13.853833 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-09 20:28:13.853857 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-09 20:28:13.853879 | debian-bookworm | cd+++++++++ src/github.com/osism/zuul-jobs/ 2025-09-09 20:28:13.853900 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004507 2025-09-09 20:28:42.177596 | 2025-09-09 20:28:42.177679 | TASK [upload-logs : Upload logs to log server] 2025-09-09 20:28:42.636819 | localhost | Output suppressed because no_log was given 2025-09-09 20:28:42.638168 | 2025-09-09 20:28:42.638240 | LOOP [upload-logs : Compress console log and json output] 2025-09-09 20:28:42.679553 | localhost | skipping: Conditional result was False 2025-09-09 20:28:42.686965 | localhost | skipping: Conditional result was False 2025-09-09 20:28:42.693430 | 2025-09-09 20:28:42.693511 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-09 20:28:42.779286 | localhost | skipping: Conditional result was False 2025-09-09 20:28:42.779534 | 2025-09-09 20:28:42.789194 | localhost | skipping: Conditional result was False 2025-09-09 20:28:42.799041 | 2025-09-09 20:28:42.799172 | LOOP [upload-logs : Upload console log and json output]