2025-10-15 15:27:47.167994 | Job console starting 2025-10-15 15:27:47.205136 | Updating git repos 2025-10-15 15:27:47.260931 | Cloning repos into workspace 2025-10-15 15:27:47.337781 | Restoring repo states 2025-10-15 15:27:47.353366 | Merging changes 2025-10-15 15:27:47.996906 | Checking out repos 2025-10-15 15:27:48.088514 | Preparing playbooks 2025-10-15 15:27:49.570475 | Running Ansible setup 2025-10-15 15:27:55.519637 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-15 15:27:56.872172 | 2025-10-15 15:27:56.872289 | PLAY [Base pre] 2025-10-15 15:27:56.887665 | 2025-10-15 15:27:56.887778 | TASK [Setup log path fact] 2025-10-15 15:27:56.915510 | debian-bookworm | ok 2025-10-15 15:27:56.930298 | 2025-10-15 15:27:56.930419 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-15 15:27:56.958584 | debian-bookworm | ok 2025-10-15 15:27:56.967912 | 2025-10-15 15:27:56.968018 | TASK [emit-job-header : Print job information] 2025-10-15 15:27:57.084000 | # Job Information 2025-10-15 15:27:57.084161 | Ansible Version: 2.16.14 2025-10-15 15:27:57.084197 | Job: container-image-cfg-cookiecutter-build 2025-10-15 15:27:57.084230 | Pipeline: check 2025-10-15 15:27:57.084254 | Executor: 521e9411259a 2025-10-15 15:27:57.084274 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/790 2025-10-15 15:27:57.084296 | Event ID: 7b008910-a9db-11f0-984c-55b4b269fcf4 2025-10-15 15:27:57.090848 | 2025-10-15 15:27:57.090950 | LOOP [emit-job-header : Print node information] 2025-10-15 15:27:57.338604 | debian-bookworm | ok: 2025-10-15 15:27:57.338775 | debian-bookworm | # Node Information 2025-10-15 15:27:57.338811 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-15 15:27:57.338851 | debian-bookworm | Hostname: debian 2025-10-15 15:27:57.338874 | debian-bookworm | Username: zuul 2025-10-15 15:27:57.338895 | debian-bookworm | Distro: Debian 12.12 2025-10-15 15:27:57.338919 | debian-bookworm | Provider: regiocloud-a 2025-10-15 15:27:57.338940 | debian-bookworm | Region: 2025-10-15 15:27:57.338961 | debian-bookworm | Label: debian-bookworm 2025-10-15 15:27:57.338980 | debian-bookworm | Product Name: OpenStack Nova 2025-10-15 15:27:57.339000 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe08:c919 2025-10-15 15:27:57.366870 | 2025-10-15 15:27:57.366993 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-15 15:27:58.078214 | debian-bookworm -> localhost | changed 2025-10-15 15:27:58.083805 | 2025-10-15 15:27:58.083887 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-15 15:27:59.674490 | debian-bookworm -> localhost | changed 2025-10-15 15:27:59.682952 | 2025-10-15 15:27:59.683038 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-15 15:28:00.117624 | debian-bookworm -> localhost | ok 2025-10-15 15:28:00.122435 | 2025-10-15 15:28:00.122521 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-15 15:28:00.138932 | debian-bookworm | ok 2025-10-15 15:28:00.174946 | debian-bookworm | included: /var/lib/zuul/builds/c42756390a6e45c8b984353bad061849/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-15 15:28:00.195863 | 2025-10-15 15:28:00.195958 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-15 15:28:02.477373 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-15 15:28:02.477537 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c42756390a6e45c8b984353bad061849/work/c42756390a6e45c8b984353bad061849_id_rsa 2025-10-15 15:28:02.477589 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c42756390a6e45c8b984353bad061849/work/c42756390a6e45c8b984353bad061849_id_rsa.pub 2025-10-15 15:28:02.477611 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-15 15:28:02.477633 | debian-bookworm -> localhost | SHA256:1fzrGXs2DGFLIA39mZuPyVUgBqSILuBGs3VGQi/0WLw zuul-build-sshkey 2025-10-15 15:28:02.477660 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-15 15:28:02.477679 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-15 15:28:02.477697 | debian-bookworm -> localhost | | .+.o o*. | 2025-10-15 15:28:02.477715 | debian-bookworm -> localhost | | . Bo . o *o . | 2025-10-15 15:28:02.477731 | debian-bookworm -> localhost | |.o +.=o . o.=.o. | 2025-10-15 15:28:02.477748 | debian-bookworm -> localhost | |o.+.+E . O .| 2025-10-15 15:28:02.477764 | debian-bookworm -> localhost | | +. . S o * .| 2025-10-15 15:28:02.477784 | debian-bookworm -> localhost | |. . = o | 2025-10-15 15:28:02.477803 | debian-bookworm -> localhost | | . X | 2025-10-15 15:28:02.477820 | debian-bookworm -> localhost | | = Bo| 2025-10-15 15:28:02.477838 | debian-bookworm -> localhost | | +o.| 2025-10-15 15:28:02.477855 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-15 15:28:02.477902 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.349885 2025-10-15 15:28:02.483042 | 2025-10-15 15:28:02.483122 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-15 15:28:02.509661 | debian-bookworm | ok 2025-10-15 15:28:02.525297 | debian-bookworm | included: /var/lib/zuul/builds/c42756390a6e45c8b984353bad061849/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-15 15:28:02.542328 | 2025-10-15 15:28:02.542420 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-15 15:28:02.565155 | debian-bookworm | skipping: Conditional result was False 2025-10-15 15:28:02.570581 | 2025-10-15 15:28:02.570675 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-15 15:28:03.236046 | debian-bookworm | changed 2025-10-15 15:28:03.247970 | 2025-10-15 15:28:03.248061 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-15 15:28:03.495468 | debian-bookworm | ok 2025-10-15 15:28:03.501253 | 2025-10-15 15:28:03.501332 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-15 15:28:04.121578 | debian-bookworm | changed 2025-10-15 15:28:04.127228 | 2025-10-15 15:28:04.127308 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-15 15:28:04.746247 | debian-bookworm | changed 2025-10-15 15:28:04.760005 | 2025-10-15 15:28:04.760109 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-15 15:28:04.783023 | debian-bookworm | skipping: Conditional result was False 2025-10-15 15:28:04.788677 | 2025-10-15 15:28:04.788775 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-15 15:28:05.278884 | debian-bookworm -> localhost | changed 2025-10-15 15:28:05.304362 | 2025-10-15 15:28:05.304459 | TASK [add-build-sshkey : Add back temp key] 2025-10-15 15:28:05.724220 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c42756390a6e45c8b984353bad061849/work/c42756390a6e45c8b984353bad061849_id_rsa (zuul-build-sshkey) 2025-10-15 15:28:05.724749 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.010632 2025-10-15 15:28:05.731281 | 2025-10-15 15:28:05.731360 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-15 15:28:06.121421 | debian-bookworm | ok 2025-10-15 15:28:06.125664 | 2025-10-15 15:28:06.125742 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-15 15:28:06.139482 | debian-bookworm | skipping: Conditional result was False 2025-10-15 15:28:06.148443 | 2025-10-15 15:28:06.148535 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-15 15:28:06.546476 | debian-bookworm | ok 2025-10-15 15:28:06.560077 | 2025-10-15 15:28:06.560185 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-15 15:28:06.607730 | debian-bookworm | ok 2025-10-15 15:28:06.611799 | 2025-10-15 15:28:06.611874 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-15 15:28:07.010999 | debian-bookworm -> localhost | ok 2025-10-15 15:28:07.016215 | 2025-10-15 15:28:07.016305 | TASK [validate-host : Collect information about the host] 2025-10-15 15:28:08.232899 | debian-bookworm | ok 2025-10-15 15:28:08.247755 | 2025-10-15 15:28:08.247865 | TASK [validate-host : Sanitize hostname] 2025-10-15 15:28:08.326288 | debian-bookworm | ok 2025-10-15 15:28:08.359435 | 2025-10-15 15:28:08.359529 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-15 15:28:09.339364 | debian-bookworm -> localhost | changed 2025-10-15 15:28:09.344037 | 2025-10-15 15:28:09.344115 | TASK [validate-host : Collect information about zuul worker] 2025-10-15 15:28:09.816390 | debian-bookworm | ok 2025-10-15 15:28:09.820187 | 2025-10-15 15:28:09.820266 | TASK [validate-host : Write out all zuul information for each host] 2025-10-15 15:28:10.487464 | debian-bookworm -> localhost | changed 2025-10-15 15:28:10.494952 | 2025-10-15 15:28:10.495040 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-15 15:28:10.788960 | debian-bookworm | ok 2025-10-15 15:28:10.793331 | 2025-10-15 15:28:10.793404 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-15 15:28:11.614594 | debian-bookworm | changed: 2025-10-15 15:28:11.614748 | debian-bookworm | cd+++++++++ src/ 2025-10-15 15:28:11.614777 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-15 15:28:11.614797 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-15 15:28:11.614815 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-10-15 15:28:11.614844 | debian-bookworm | Containerfile 2025-10-15 15:28:11.614956 | debian-bookworm | localhost | ok: Runtime: 0:00:00.007307 2025-10-15 15:29:36.119803 | 2025-10-15 15:29:36.119995 | TASK [upload-logs : Upload logs to log server] 2025-10-15 15:29:36.674280 | localhost | Output suppressed because no_log was given 2025-10-15 15:29:36.677204 | 2025-10-15 15:29:36.677355 | LOOP [upload-logs : Compress console log and json output] 2025-10-15 15:29:36.737719 | localhost | skipping: Conditional result was False 2025-10-15 15:29:36.743169 | localhost | skipping: Conditional result was False 2025-10-15 15:29:36.750771 | 2025-10-15 15:29:36.751046 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-15 15:29:36.827175 | localhost | skipping: Conditional result was False 2025-10-15 15:29:36.827741 | 2025-10-15 15:29:36.832960 | localhost | skipping: Conditional result was False 2025-10-15 15:29:36.842716 | 2025-10-15 15:29:36.842824 | LOOP [upload-logs : Upload console log and json output]