2026-01-29 21:02:20.299605 | Job console starting 2026-01-29 21:02:20.349486 | Updating git repos 2026-01-29 21:02:20.424472 | Cloning repos into workspace 2026-01-29 21:02:20.495963 | Restoring repo states 2026-01-29 21:02:20.516684 | Merging changes 2026-01-29 21:02:21.213154 | Checking out repos 2026-01-29 21:02:21.329851 | Preparing playbooks 2026-01-29 21:02:23.197472 | Running Ansible setup 2026-01-29 21:02:28.210235 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-29 21:02:29.587011 | 2026-01-29 21:02:29.587128 | PLAY [Base pre] 2026-01-29 21:02:29.624034 | 2026-01-29 21:02:29.624145 | TASK [Setup log path fact] 2026-01-29 21:02:29.665279 | debian-bookworm | ok 2026-01-29 21:02:29.677060 | 2026-01-29 21:02:29.677168 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-29 21:02:29.762866 | debian-bookworm | ok 2026-01-29 21:02:29.779063 | 2026-01-29 21:02:29.779166 | TASK [emit-job-header : Print job information] 2026-01-29 21:02:29.836982 | # Job Information 2026-01-29 21:02:29.837116 | Ansible Version: 2.16.14 2026-01-29 21:02:29.837145 | Job: container-image-cfg-cookiecutter-build 2026-01-29 21:02:29.837171 | Pipeline: check 2026-01-29 21:02:29.837190 | Executor: 521e9411259a 2026-01-29 21:02:29.837207 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/811 2026-01-29 21:02:29.837225 | Event ID: c4d73110-fd55-11f0-8a6f-5d0ab7cccfd5 2026-01-29 21:02:29.841155 | 2026-01-29 21:02:29.841236 | LOOP [emit-job-header : Print node information] 2026-01-29 21:02:29.942992 | debian-bookworm | ok: 2026-01-29 21:02:29.943167 | debian-bookworm | # Node Information 2026-01-29 21:02:29.943198 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-29 21:02:29.943219 | debian-bookworm | Hostname: debian 2026-01-29 21:02:29.943237 | debian-bookworm | Username: zuul 2026-01-29 21:02:29.943254 | debian-bookworm | Distro: Debian 12.13 2026-01-29 21:02:29.943275 | debian-bookworm | Provider: regiocloud-a 2026-01-29 21:02:29.943292 | debian-bookworm | Region: 2026-01-29 21:02:29.943309 | debian-bookworm | Label: debian-bookworm 2026-01-29 21:02:29.943333 | debian-bookworm | Product Name: OpenStack Nova 2026-01-29 21:02:29.943350 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe71:e66a 2026-01-29 21:02:29.961626 | 2026-01-29 21:02:29.961723 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-29 21:02:30.911619 | debian-bookworm -> localhost | changed 2026-01-29 21:02:30.917466 | 2026-01-29 21:02:30.917561 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-29 21:02:32.697853 | debian-bookworm -> localhost | changed 2026-01-29 21:02:32.706291 | 2026-01-29 21:02:32.706376 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-29 21:02:33.361213 | debian-bookworm -> localhost | ok 2026-01-29 21:02:33.366053 | 2026-01-29 21:02:33.366129 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-29 21:02:33.422436 | debian-bookworm | ok 2026-01-29 21:02:33.448143 | debian-bookworm | included: /var/lib/zuul/builds/98f8830f13034629955b86a2b67cad06/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-29 21:02:33.454741 | 2026-01-29 21:02:33.454860 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-29 21:02:35.758735 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-29 21:02:35.758944 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/98f8830f13034629955b86a2b67cad06/work/98f8830f13034629955b86a2b67cad06_id_rsa 2026-01-29 21:02:35.758979 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/98f8830f13034629955b86a2b67cad06/work/98f8830f13034629955b86a2b67cad06_id_rsa.pub 2026-01-29 21:02:35.759001 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-29 21:02:35.759022 | debian-bookworm -> localhost | SHA256:RFIYZ33NbX9M6/oMqGjrtugaPkAokIYfWnrQLyxlX/k zuul-build-sshkey 2026-01-29 21:02:35.759048 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-29 21:02:35.759066 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-29 21:02:35.759083 | debian-bookworm -> localhost | |.o o==. o . | 2026-01-29 21:02:35.759101 | debian-bookworm -> localhost | |=.* += . . o +| 2026-01-29 21:02:35.759118 | debian-bookworm -> localhost | |+X + . .. . +o| 2026-01-29 21:02:35.759134 | debian-bookworm -> localhost | |*.= o .E .+| 2026-01-29 21:02:35.759150 | debian-bookworm -> localhost | |oo . S . .| 2026-01-29 21:02:35.759174 | debian-bookworm -> localhost | | . . . | 2026-01-29 21:02:35.759192 | debian-bookworm -> localhost | | .. . .. | 2026-01-29 21:02:35.759209 | debian-bookworm -> localhost | | ... .o. . .o | 2026-01-29 21:02:35.759226 | debian-bookworm -> localhost | | o+o+=o. .o | 2026-01-29 21:02:35.759242 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-29 21:02:35.759287 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.101737 2026-01-29 21:02:35.764358 | 2026-01-29 21:02:35.764429 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-29 21:02:35.790884 | debian-bookworm | ok 2026-01-29 21:02:35.799187 | debian-bookworm | included: /var/lib/zuul/builds/98f8830f13034629955b86a2b67cad06/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-29 21:02:35.821631 | 2026-01-29 21:02:35.821723 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-29 21:02:35.844641 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:35.850084 | 2026-01-29 21:02:35.850167 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-29 21:02:36.518688 | debian-bookworm | changed 2026-01-29 21:02:36.523895 | 2026-01-29 21:02:36.523980 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-29 21:02:36.846440 | debian-bookworm | ok 2026-01-29 21:02:36.851190 | 2026-01-29 21:02:36.851275 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-29 21:02:37.588510 | debian-bookworm | changed 2026-01-29 21:02:37.594910 | 2026-01-29 21:02:37.595008 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-29 21:02:38.271384 | debian-bookworm | changed 2026-01-29 21:02:38.286779 | 2026-01-29 21:02:38.286979 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-29 21:02:38.327044 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:38.333212 | 2026-01-29 21:02:38.333315 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-29 21:02:39.305868 | debian-bookworm -> localhost | changed 2026-01-29 21:02:39.324305 | 2026-01-29 21:02:39.324418 | TASK [add-build-sshkey : Add back temp key] 2026-01-29 21:02:39.727472 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/98f8830f13034629955b86a2b67cad06/work/98f8830f13034629955b86a2b67cad06_id_rsa (zuul-build-sshkey) 2026-01-29 21:02:39.727686 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023332 2026-01-29 21:02:39.735367 | 2026-01-29 21:02:39.735474 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-29 21:02:40.148676 | debian-bookworm | ok 2026-01-29 21:02:40.153552 | 2026-01-29 21:02:40.153643 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-29 21:02:40.177188 | debian-bookworm | skipping: Conditional result was False 2026-01-29 21:02:40.209096 | 2026-01-29 21:02:40.209195 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-29 21:02:40.656329 | debian-bookworm | ok 2026-01-29 21:02:40.671136 | 2026-01-29 21:02:40.671239 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-29 21:02:40.718343 | debian-bookworm | ok 2026-01-29 21:02:40.730908 | 2026-01-29 21:02:40.730998 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-29 21:02:41.354382 | debian-bookworm -> localhost | ok 2026-01-29 21:02:41.360497 | 2026-01-29 21:02:41.360593 | TASK [validate-host : Collect information about the host] 2026-01-29 21:02:42.818414 | debian-bookworm | ok 2026-01-29 21:02:42.828184 | 2026-01-29 21:02:42.828278 | TASK [validate-host : Sanitize hostname] 2026-01-29 21:02:42.934797 | debian-bookworm | ok 2026-01-29 21:02:42.974113 | 2026-01-29 21:02:42.974218 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-29 21:02:43.853992 | debian-bookworm -> localhost | changed 2026-01-29 21:02:43.860599 | 2026-01-29 21:02:43.860702 | TASK [validate-host : Collect information about zuul worker] 2026-01-29 21:02:44.323530 | debian-bookworm | ok 2026-01-29 21:02:44.329287 | 2026-01-29 21:02:44.329393 | TASK [validate-host : Write out all zuul information for each host] 2026-01-29 21:02:45.561401 | debian-bookworm -> localhost | changed 2026-01-29 21:02:45.579411 | 2026-01-29 21:02:45.579558 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-29 21:02:45.925260 | debian-bookworm | ok 2026-01-29 21:02:45.932646 | 2026-01-29 21:02:45.932809 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-29 21:02:47.433789 | debian-bookworm | changed: 2026-01-29 21:02:47.434017 | debian-bookworm | cd+++++++++ src/ 2026-01-29 21:02:47.434054 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-29 21:02:47.434079 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-29 21:02:47.434101 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-01-29 21:02:47.434121 | debian-bookworm | Containerfile 2026-01-29 21:02:47.434251 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006741 2026-01-29 21:04:32.332073 | 2026-01-29 21:04:32.332186 | TASK [upload-logs : Upload logs to log server] 2026-01-29 21:04:32.884008 | localhost | Output suppressed because no_log was given 2026-01-29 21:04:32.886496 | 2026-01-29 21:04:32.886627 | LOOP [upload-logs : Compress console log and json output] 2026-01-29 21:04:32.951672 | localhost | skipping: Conditional result was False 2026-01-29 21:04:32.959700 | localhost | skipping: Conditional result was False 2026-01-29 21:04:32.965649 | 2026-01-29 21:04:32.965806 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-29 21:04:33.014197 | localhost | skipping: Conditional result was False 2026-01-29 21:04:33.014466 | 2026-01-29 21:04:33.020890 | localhost | skipping: Conditional result was False 2026-01-29 21:04:33.032511 | 2026-01-29 21:04:33.032620 | LOOP [upload-logs : Upload console log and json output]