2025-11-28 03:11:51.727094 | Job console starting 2025-11-28 03:11:51.738606 | Updating git repos 2025-11-28 03:11:51.783800 | Cloning repos into workspace 2025-11-28 03:11:51.904821 | Restoring repo states 2025-11-28 03:11:51.923920 | Merging changes 2025-11-28 03:11:51.923944 | Checking out repos 2025-11-28 03:11:52.003077 | Preparing playbooks 2025-11-28 03:11:53.508095 | Running Ansible setup 2025-11-28 03:12:00.254761 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-28 03:12:01.308860 | 2025-11-28 03:12:01.308984 | PLAY [Base pre] 2025-11-28 03:12:01.342562 | 2025-11-28 03:12:01.342673 | TASK [Setup log path fact] 2025-11-28 03:12:01.379718 | debian-bookworm | ok 2025-11-28 03:12:01.404121 | 2025-11-28 03:12:01.404240 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-28 03:12:01.442723 | debian-bookworm | ok 2025-11-28 03:12:01.452271 | 2025-11-28 03:12:01.452402 | TASK [emit-job-header : Print job information] 2025-11-28 03:12:01.490064 | # Job Information 2025-11-28 03:12:01.490213 | Ansible Version: 2.16.14 2025-11-28 03:12:01.490242 | Job: python-black 2025-11-28 03:12:01.490268 | Pipeline: periodic-daily 2025-11-28 03:12:01.490286 | Executor: 521e9411259a 2025-11-28 03:12:01.490302 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-11-28 03:12:01.490321 | Event ID: bc7bc363a0ab40ddb8f5612ba5d8198e 2025-11-28 03:12:01.494426 | 2025-11-28 03:12:01.494514 | LOOP [emit-job-header : Print node information] 2025-11-28 03:12:01.608471 | debian-bookworm | ok: 2025-11-28 03:12:01.608636 | debian-bookworm | # Node Information 2025-11-28 03:12:01.608670 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-28 03:12:01.608696 | debian-bookworm | Hostname: debian 2025-11-28 03:12:01.608718 | debian-bookworm | Username: zuul 2025-11-28 03:12:01.608739 | debian-bookworm | Distro: Debian 12.12 2025-11-28 03:12:01.608762 | debian-bookworm | Provider: regiocloud-a 2025-11-28 03:12:01.608783 | debian-bookworm | Region: 2025-11-28 03:12:01.608805 | debian-bookworm | Label: debian-bookworm 2025-11-28 03:12:01.608826 | debian-bookworm | Product Name: OpenStack Nova 2025-11-28 03:12:01.608845 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe36:a9a4 2025-11-28 03:12:01.622268 | 2025-11-28 03:12:01.622389 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-28 03:12:02.113113 | debian-bookworm -> localhost | changed 2025-11-28 03:12:02.120159 | 2025-11-28 03:12:02.120264 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-28 03:12:03.300136 | debian-bookworm -> localhost | changed 2025-11-28 03:12:03.310496 | 2025-11-28 03:12:03.310612 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-28 03:12:03.566209 | debian-bookworm -> localhost | ok 2025-11-28 03:12:03.572083 | 2025-11-28 03:12:03.572186 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-28 03:12:03.589625 | debian-bookworm | ok 2025-11-28 03:12:03.606975 | debian-bookworm | included: /var/lib/zuul/builds/2af32b2894484b8593b18a07e4a95aa1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-28 03:12:03.612921 | 2025-11-28 03:12:03.613016 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-28 03:12:04.751462 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-28 03:12:04.751654 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2af32b2894484b8593b18a07e4a95aa1/work/2af32b2894484b8593b18a07e4a95aa1_id_rsa 2025-11-28 03:12:04.751691 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2af32b2894484b8593b18a07e4a95aa1/work/2af32b2894484b8593b18a07e4a95aa1_id_rsa.pub 2025-11-28 03:12:04.751717 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-28 03:12:04.751740 | debian-bookworm -> localhost | SHA256:dEWtoTb2maobUW4rC5GW8iIrbdz/63HsasBdlMoGvyk zuul-build-sshkey 2025-11-28 03:12:04.751976 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-28 03:12:04.752017 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-28 03:12:04.752042 | debian-bookworm -> localhost | | oo. | 2025-11-28 03:12:04.752066 | debian-bookworm -> localhost | | . o.. . | 2025-11-28 03:12:04.752087 | debian-bookworm -> localhost | | +.oo. o | 2025-11-28 03:12:04.752107 | debian-bookworm -> localhost | | +=+* . | 2025-11-28 03:12:04.752128 | debian-bookworm -> localhost | | ..=oS*oo o | 2025-11-28 03:12:04.752152 | debian-bookworm -> localhost | | +E.++ .+ | 2025-11-28 03:12:04.752173 | debian-bookworm -> localhost | | o... oo+ +. | 2025-11-28 03:12:04.752193 | debian-bookworm -> localhost | |. +o.. ..B. | 2025-11-28 03:12:04.752215 | debian-bookworm -> localhost | | o. ..+O=. | 2025-11-28 03:12:04.752236 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-28 03:12:04.752288 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.697427 2025-11-28 03:12:04.758549 | 2025-11-28 03:12:04.758648 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-28 03:12:04.775724 | debian-bookworm | ok 2025-11-28 03:12:04.784649 | debian-bookworm | included: /var/lib/zuul/builds/2af32b2894484b8593b18a07e4a95aa1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-28 03:12:04.793613 | 2025-11-28 03:12:04.793700 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-28 03:12:04.806458 | debian-bookworm | skipping: Conditional result was False 2025-11-28 03:12:04.813064 | 2025-11-28 03:12:04.813160 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-28 03:12:05.476337 | debian-bookworm | changed 2025-11-28 03:12:05.483360 | 2025-11-28 03:12:05.483485 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-28 03:12:05.734725 | debian-bookworm | ok 2025-11-28 03:12:05.750469 | 2025-11-28 03:12:05.750624 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-28 03:12:06.496640 | debian-bookworm | changed 2025-11-28 03:12:06.505451 | 2025-11-28 03:12:06.505591 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-28 03:12:07.186425 | debian-bookworm | changed 2025-11-28 03:12:07.192896 | 2025-11-28 03:12:07.193021 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-28 03:12:07.217000 | debian-bookworm | skipping: Conditional result was False 2025-11-28 03:12:07.224168 | 2025-11-28 03:12:07.224289 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-28 03:12:07.906118 | debian-bookworm -> localhost | changed 2025-11-28 03:12:07.922296 | 2025-11-28 03:12:07.922554 | TASK [add-build-sshkey : Add back temp key] 2025-11-28 03:12:08.534046 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2af32b2894484b8593b18a07e4a95aa1/work/2af32b2894484b8593b18a07e4a95aa1_id_rsa (zuul-build-sshkey) 2025-11-28 03:12:08.534763 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025310 2025-11-28 03:12:08.552295 | 2025-11-28 03:12:08.552477 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-28 03:12:09.053523 | debian-bookworm | ok 2025-11-28 03:12:09.061656 | 2025-11-28 03:12:09.061794 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-28 03:12:09.111409 | debian-bookworm | skipping: Conditional result was False 2025-11-28 03:12:09.123116 | 2025-11-28 03:12:09.123251 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-28 03:12:09.585873 | debian-bookworm | ok 2025-11-28 03:12:09.615910 | 2025-11-28 03:12:09.616267 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-28 03:12:09.669583 | debian-bookworm | ok 2025-11-28 03:12:09.674961 | 2025-11-28 03:12:09.675079 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-28 03:12:10.201785 | debian-bookworm -> localhost | ok 2025-11-28 03:12:10.212156 | 2025-11-28 03:12:10.212330 | TASK [validate-host : Collect information about the host] 2025-11-28 03:12:11.555234 | debian-bookworm | ok 2025-11-28 03:12:11.576919 | 2025-11-28 03:12:11.577062 | TASK [validate-host : Sanitize hostname] 2025-11-28 03:12:11.721805 | debian-bookworm | ok 2025-11-28 03:12:11.767902 | 2025-11-28 03:12:11.768051 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-28 03:12:12.496088 | debian-bookworm -> localhost | changed 2025-11-28 03:12:12.504657 | 2025-11-28 03:12:12.504797 | TASK [validate-host : Collect information about zuul worker] 2025-11-28 03:12:13.024011 | debian-bookworm | ok 2025-11-28 03:12:13.031970 | 2025-11-28 03:12:13.032102 | TASK [validate-host : Write out all zuul information for each host] 2025-11-28 03:12:13.661870 | debian-bookworm -> localhost | changed 2025-11-28 03:12:13.678304 | 2025-11-28 03:12:13.678535 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-28 03:12:13.960472 | debian-bookworm | ok 2025-11-28 03:12:13.966396 | 2025-11-28 03:12:13.966509 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-28 03:12:14.896735 | debian-bookworm | changed: 2025-11-28 03:12:14.896948 | debian-bookworm | cd+++++++++ src/ 2025-11-28 03:12:14.896985 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-28 03:12:14.897012 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-28 03:12:14.897036 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-11-28 03:12:14.897059 | debian-bookworm | Containerfile 2025-11-28 03:12:14.897287 | debian-bookworm | localhost | ok: Runtime: 0:00:00.036300 2025-11-28 03:12:40.354631 | 2025-11-28 03:12:40.354767 | TASK [upload-logs : Upload logs to log server] 2025-11-28 03:12:40.978103 | localhost | Output suppressed because no_log was given 2025-11-28 03:12:40.980701 | 2025-11-28 03:12:40.980840 | LOOP [upload-logs : Compress console log and json output] 2025-11-28 03:12:41.040824 | localhost | skipping: Conditional result was False 2025-11-28 03:12:41.047582 | localhost | skipping: Conditional result was False 2025-11-28 03:12:41.065459 | 2025-11-28 03:12:41.065940 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-28 03:12:41.131406 | localhost | skipping: Conditional result was False 2025-11-28 03:12:41.131717 | 2025-11-28 03:12:41.139127 | localhost | skipping: Conditional result was False 2025-11-28 03:12:41.145419 | 2025-11-28 03:12:41.145550 | LOOP [upload-logs : Upload console log and json output]