2025-08-29 03:13:47.744264 | Job console starting 2025-08-29 03:13:47.757885 | Updating git repos 2025-08-29 03:13:47.784922 | Cloning repos into workspace 2025-08-29 03:13:47.838810 | Restoring repo states 2025-08-29 03:13:47.845232 | Merging changes 2025-08-29 03:13:47.845247 | Checking out repos 2025-08-29 03:13:47.905686 | Preparing playbooks 2025-08-29 03:13:48.622295 | Running Ansible setup 2025-08-29 03:13:53.147415 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-29 03:13:53.983347 | 2025-08-29 03:13:53.983526 | PLAY [Base pre] 2025-08-29 03:13:54.000833 | 2025-08-29 03:13:54.000997 | TASK [Setup log path fact] 2025-08-29 03:13:54.029810 | debian-bookworm | ok 2025-08-29 03:13:54.045560 | 2025-08-29 03:13:54.045725 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-29 03:13:54.076901 | debian-bookworm | ok 2025-08-29 03:13:54.087353 | 2025-08-29 03:13:54.087493 | TASK [emit-job-header : Print job information] 2025-08-29 03:13:54.153060 | # Job Information 2025-08-29 03:13:54.153259 | Ansible Version: 2.16.14 2025-08-29 03:13:54.153296 | Job: python-black 2025-08-29 03:13:54.153329 | Pipeline: periodic-daily 2025-08-29 03:13:54.153353 | Executor: 521e9411259a 2025-08-29 03:13:54.153373 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-08-29 03:13:54.153395 | Event ID: 3d07150dd1a9493ca8af10e1abf630c7 2025-08-29 03:13:54.158614 | 2025-08-29 03:13:54.158738 | LOOP [emit-job-header : Print node information] 2025-08-29 03:13:54.296753 | debian-bookworm | ok: 2025-08-29 03:13:54.296985 | debian-bookworm | # Node Information 2025-08-29 03:13:54.297021 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-29 03:13:54.297047 | debian-bookworm | Hostname: debian 2025-08-29 03:13:54.297069 | debian-bookworm | Username: zuul 2025-08-29 03:13:54.297090 | debian-bookworm | Distro: Debian 12.11 2025-08-29 03:13:54.297115 | debian-bookworm | Provider: regiocloud-a 2025-08-29 03:13:54.297136 | debian-bookworm | Region: 2025-08-29 03:13:54.297157 | debian-bookworm | Label: debian-bookworm 2025-08-29 03:13:54.297176 | debian-bookworm | Product Name: OpenStack Nova 2025-08-29 03:13:54.297195 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe48:c9a4 2025-08-29 03:13:54.310355 | 2025-08-29 03:13:54.310484 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-29 03:13:54.915103 | debian-bookworm -> localhost | changed 2025-08-29 03:13:54.922555 | 2025-08-29 03:13:54.922676 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-29 03:13:56.525447 | debian-bookworm -> localhost | changed 2025-08-29 03:13:56.547660 | 2025-08-29 03:13:56.547826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-29 03:13:57.237041 | debian-bookworm -> localhost | ok 2025-08-29 03:13:57.243844 | 2025-08-29 03:13:57.243973 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-29 03:13:57.286169 | debian-bookworm | ok 2025-08-29 03:13:57.341708 | debian-bookworm | included: /var/lib/zuul/builds/1e1bab2ef03b43a7a8b3a0ee35039d87/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-29 03:13:57.355823 | 2025-08-29 03:13:57.355962 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-29 03:14:00.663335 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-29 03:14:00.663538 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1e1bab2ef03b43a7a8b3a0ee35039d87/work/1e1bab2ef03b43a7a8b3a0ee35039d87_id_rsa 2025-08-29 03:14:00.663577 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1e1bab2ef03b43a7a8b3a0ee35039d87/work/1e1bab2ef03b43a7a8b3a0ee35039d87_id_rsa.pub 2025-08-29 03:14:00.663602 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-29 03:14:00.663625 | debian-bookworm -> localhost | SHA256:iA+b0WYAOHdOCx33vSQBVXkIEXMOTHH1wsERiYqc3II zuul-build-sshkey 2025-08-29 03:14:00.663647 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-29 03:14:00.663677 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-29 03:14:00.663699 | debian-bookworm -> localhost | | .....o=@*+*=+ | 2025-08-29 03:14:00.663720 | debian-bookworm -> localhost | |o o.+. ..O+.+o | 2025-08-29 03:14:00.663740 | debian-bookworm -> localhost | | o =.= +o.+.o . | 2025-08-29 03:14:00.663787 | debian-bookworm -> localhost | | E+*.oo . . | 2025-08-29 03:14:00.663809 | debian-bookworm -> localhost | | + =.S . | 2025-08-29 03:14:00.663834 | debian-bookworm -> localhost | | O | 2025-08-29 03:14:00.663854 | debian-bookworm -> localhost | | o . | 2025-08-29 03:14:00.663874 | debian-bookworm -> localhost | | | 2025-08-29 03:14:00.663894 | debian-bookworm -> localhost | | | 2025-08-29 03:14:00.663913 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-29 03:14:00.663962 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.232689 2025-08-29 03:14:00.670468 | 2025-08-29 03:14:00.670558 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-29 03:14:00.713240 | debian-bookworm | ok 2025-08-29 03:14:00.730064 | debian-bookworm | included: /var/lib/zuul/builds/1e1bab2ef03b43a7a8b3a0ee35039d87/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-29 03:14:00.771678 | 2025-08-29 03:14:00.771819 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-29 03:14:00.793614 | debian-bookworm | skipping: Conditional result was False 2025-08-29 03:14:00.801192 | 2025-08-29 03:14:00.801302 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-29 03:14:01.622449 | debian-bookworm | changed 2025-08-29 03:14:01.637219 | 2025-08-29 03:14:01.637333 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-29 03:14:01.905556 | debian-bookworm | ok 2025-08-29 03:14:01.910992 | 2025-08-29 03:14:01.911079 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-29 03:14:02.650023 | debian-bookworm | changed 2025-08-29 03:14:02.660411 | 2025-08-29 03:14:02.660533 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-29 03:14:03.428564 | debian-bookworm | changed 2025-08-29 03:14:03.437333 | 2025-08-29 03:14:03.437418 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-29 03:14:03.470305 | debian-bookworm | skipping: Conditional result was False 2025-08-29 03:14:03.476910 | 2025-08-29 03:14:03.476996 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-29 03:14:04.206419 | debian-bookworm -> localhost | changed 2025-08-29 03:14:04.215191 | 2025-08-29 03:14:04.215276 | TASK [add-build-sshkey : Add back temp key] 2025-08-29 03:14:04.813773 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1e1bab2ef03b43a7a8b3a0ee35039d87/work/1e1bab2ef03b43a7a8b3a0ee35039d87_id_rsa (zuul-build-sshkey) 2025-08-29 03:14:04.813951 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036652 2025-08-29 03:14:04.820242 | 2025-08-29 03:14:04.820321 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-29 03:14:05.575457 | debian-bookworm | ok 2025-08-29 03:14:05.580389 | 2025-08-29 03:14:05.580482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-29 03:14:05.611974 | debian-bookworm | skipping: Conditional result was False 2025-08-29 03:14:05.622045 | 2025-08-29 03:14:05.622140 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-29 03:14:06.237028 | debian-bookworm | ok 2025-08-29 03:14:06.257038 | 2025-08-29 03:14:06.257141 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-29 03:14:06.319626 | debian-bookworm | ok 2025-08-29 03:14:06.324427 | 2025-08-29 03:14:06.324513 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-29 03:14:06.716154 | debian-bookworm -> localhost | ok 2025-08-29 03:14:06.722436 | 2025-08-29 03:14:06.722526 | TASK [validate-host : Collect information about the host] 2025-08-29 03:14:07.838486 | debian-bookworm | ok 2025-08-29 03:14:07.849934 | 2025-08-29 03:14:07.850032 | TASK [validate-host : Sanitize hostname] 2025-08-29 03:14:07.928742 | debian-bookworm | ok 2025-08-29 03:14:07.957329 | 2025-08-29 03:14:07.957430 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-29 03:14:08.385154 | debian-bookworm -> localhost | changed 2025-08-29 03:14:08.390524 | 2025-08-29 03:14:08.390606 | TASK [validate-host : Collect information about zuul worker] 2025-08-29 03:14:08.791131 | debian-bookworm | ok 2025-08-29 03:14:08.797199 | 2025-08-29 03:14:08.797284 | TASK [validate-host : Write out all zuul information for each host] 2025-08-29 03:14:09.288860 | debian-bookworm -> localhost | changed 2025-08-29 03:14:09.297679 | 2025-08-29 03:14:09.297794 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-29 03:14:09.554133 | debian-bookworm | ok 2025-08-29 03:14:09.559409 | 2025-08-29 03:14:09.559502 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-29 03:14:10.415665 | debian-bookworm | changed: 2025-08-29 03:14:10.415904 | debian-bookworm | cd+++++++++ src/ 2025-08-29 03:14:10.415944 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-29 03:14:10.415969 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-29 03:14:10.415992 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-08-29 03:14:10.416012 | debian-bookworm | Containerfile 2025-08-29 03:14:10.416142 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005423 2025-08-29 03:14:35.568361 | 2025-08-29 03:14:35.568533 | TASK [upload-logs : Upload logs to log server] 2025-08-29 03:14:36.136085 | localhost | Output suppressed because no_log was given 2025-08-29 03:14:36.140297 | 2025-08-29 03:14:36.140517 | LOOP [upload-logs : Compress console log and json output] 2025-08-29 03:14:36.192588 | localhost | skipping: Conditional result was False 2025-08-29 03:14:36.201151 | localhost | skipping: Conditional result was False 2025-08-29 03:14:36.213353 | 2025-08-29 03:14:36.213570 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-29 03:14:36.277114 | localhost | skipping: Conditional result was False 2025-08-29 03:14:36.277800 | 2025-08-29 03:14:36.281592 | localhost | skipping: Conditional result was False 2025-08-29 03:14:36.296572 | 2025-08-29 03:14:36.296880 | LOOP [upload-logs : Upload console log and json output]