2025-06-05 03:22:56.833617 | Job console starting 2025-06-05 03:22:56.845725 | Updating git repos 2025-06-05 03:22:56.887498 | Cloning repos into workspace 2025-06-05 03:22:56.984371 | Restoring repo states 2025-06-05 03:22:57.004897 | Merging changes 2025-06-05 03:22:57.004917 | Checking out repos 2025-06-05 03:22:57.136474 | Preparing playbooks 2025-06-05 03:22:58.567993 | Running Ansible setup 2025-06-05 03:23:05.079750 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-06-05 03:23:06.065705 | 2025-06-05 03:23:06.065910 | PLAY [Base pre] 2025-06-05 03:23:06.082750 | 2025-06-05 03:23:06.082923 | TASK [Setup log path fact] 2025-06-05 03:23:06.117015 | debian-bookworm | ok 2025-06-05 03:23:06.141605 | 2025-06-05 03:23:06.141889 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-06-05 03:23:06.184209 | debian-bookworm | ok 2025-06-05 03:23:06.197871 | 2025-06-05 03:23:06.198019 | TASK [emit-job-header : Print job information] 2025-06-05 03:23:06.249934 | # Job Information 2025-06-05 03:23:06.250158 | Ansible Version: 2.16.14 2025-06-05 03:23:06.250196 | Job: container-image-cfg-cookiecutter-push 2025-06-05 03:23:06.250231 | Pipeline: periodic-daily 2025-06-05 03:23:06.250256 | Executor: 521e9411259a 2025-06-05 03:23:06.250277 | Triggered by: https://github.com/osism/cfg-cookiecutter 2025-06-05 03:23:06.250300 | Event ID: ece793385b554960b8346f7f95b617a8 2025-06-05 03:23:06.255795 | 2025-06-05 03:23:06.255927 | LOOP [emit-job-header : Print node information] 2025-06-05 03:23:06.377490 | debian-bookworm | ok: 2025-06-05 03:23:06.377717 | debian-bookworm | # Node Information 2025-06-05 03:23:06.377754 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-06-05 03:23:06.377781 | debian-bookworm | Hostname: debian 2025-06-05 03:23:06.377805 | debian-bookworm | Username: zuul 2025-06-05 03:23:06.377826 | debian-bookworm | Distro: Debian 12.11 2025-06-05 03:23:06.377852 | debian-bookworm | Provider: regiocloud-a 2025-06-05 03:23:06.377875 | debian-bookworm | Region: 2025-06-05 03:23:06.377896 | debian-bookworm | Label: debian-bookworm 2025-06-05 03:23:06.377916 | debian-bookworm | Product Name: OpenStack Nova 2025-06-05 03:23:06.377937 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feca:a99d 2025-06-05 03:23:06.406191 | 2025-06-05 03:23:06.406437 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-06-05 03:23:06.897270 | debian-bookworm -> localhost | changed 2025-06-05 03:23:06.905564 | 2025-06-05 03:23:06.905703 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-06-05 03:23:08.084183 | debian-bookworm -> localhost | changed 2025-06-05 03:23:08.096183 | 2025-06-05 03:23:08.096316 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-06-05 03:23:08.395522 | debian-bookworm -> localhost | ok 2025-06-05 03:23:08.405136 | 2025-06-05 03:23:08.405282 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-06-05 03:23:08.434352 | debian-bookworm | ok 2025-06-05 03:23:08.452882 | debian-bookworm | included: /var/lib/zuul/builds/4d06916a55d740cc99efc00d961f2713/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-06-05 03:23:08.466083 | 2025-06-05 03:23:08.466205 | TASK [add-build-sshkey : Create Temp SSH key] 2025-06-05 03:23:09.402641 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-06-05 03:23:09.403021 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/4d06916a55d740cc99efc00d961f2713/work/4d06916a55d740cc99efc00d961f2713_id_rsa 2025-06-05 03:23:09.403069 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/4d06916a55d740cc99efc00d961f2713/work/4d06916a55d740cc99efc00d961f2713_id_rsa.pub 2025-06-05 03:23:09.403096 | debian-bookworm -> localhost | The key fingerprint is: 2025-06-05 03:23:09.403123 | debian-bookworm -> localhost | SHA256:Zsj7eAyHf5AQB4q3yVY35UEe4gSEZO5l1Sv7mXeWRh8 zuul-build-sshkey 2025-06-05 03:23:09.403157 | debian-bookworm -> localhost | The key's randomart image is: 2025-06-05 03:23:09.403179 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-06-05 03:23:09.403200 | debian-bookworm -> localhost | | .oo+o+o= | 2025-06-05 03:23:09.403221 | debian-bookworm -> localhost | | +...+.=.o | 2025-06-05 03:23:09.403242 | debian-bookworm -> localhost | | . + +o+ o. | 2025-06-05 03:23:09.403261 | debian-bookworm -> localhost | | + B.o... | 2025-06-05 03:23:09.403281 | debian-bookworm -> localhost | | * ooS+ | 2025-06-05 03:23:09.403313 | debian-bookworm -> localhost | | . o+= .E | 2025-06-05 03:23:09.403335 | debian-bookworm -> localhost | | .= o o . o.| 2025-06-05 03:23:09.403355 | debian-bookworm -> localhost | | o+ = . = .| 2025-06-05 03:23:09.403392 | debian-bookworm -> localhost | | .... . + | 2025-06-05 03:23:09.403414 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-06-05 03:23:09.403488 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.310178 2025-06-05 03:23:09.410634 | 2025-06-05 03:23:09.410761 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-06-05 03:23:09.450682 | debian-bookworm | ok 2025-06-05 03:23:09.462116 | debian-bookworm | included: /var/lib/zuul/builds/4d06916a55d740cc99efc00d961f2713/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-06-05 03:23:09.471629 | 2025-06-05 03:23:09.471739 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-06-05 03:23:09.506020 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:23:09.518216 | 2025-06-05 03:23:09.518420 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-06-05 03:23:10.229661 | debian-bookworm | changed 2025-06-05 03:23:10.239921 | 2025-06-05 03:23:10.240053 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-06-05 03:23:10.550816 | debian-bookworm | ok 2025-06-05 03:23:10.557837 | 2025-06-05 03:23:10.557956 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-06-05 03:23:11.242736 | debian-bookworm | changed 2025-06-05 03:23:11.254728 | 2025-06-05 03:23:11.254881 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-06-05 03:23:12.029975 | debian-bookworm | changed 2025-06-05 03:23:12.038207 | 2025-06-05 03:23:12.038348 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-06-05 03:23:12.063033 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:23:12.069694 | 2025-06-05 03:23:12.069822 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-06-05 03:23:12.575096 | debian-bookworm -> localhost | changed 2025-06-05 03:23:12.591365 | 2025-06-05 03:23:12.591521 | TASK [add-build-sshkey : Add back temp key] 2025-06-05 03:23:13.086251 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/4d06916a55d740cc99efc00d961f2713/work/4d06916a55d740cc99efc00d961f2713_id_rsa (zuul-build-sshkey) 2025-06-05 03:23:13.086748 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023102 2025-06-05 03:23:13.119959 | 2025-06-05 03:23:13.120111 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-06-05 03:23:13.615780 | debian-bookworm | ok 2025-06-05 03:23:13.622167 | 2025-06-05 03:23:13.622320 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-06-05 03:23:13.647428 | debian-bookworm | skipping: Conditional result was False 2025-06-05 03:23:13.659349 | 2025-06-05 03:23:13.659522 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-06-05 03:23:14.133933 | debian-bookworm | ok 2025-06-05 03:23:14.148125 | 2025-06-05 03:23:14.148272 | TASK [validate-host : Define zuul_info_dir fact] 2025-06-05 03:23:14.177853 | debian-bookworm | ok 2025-06-05 03:23:14.184110 | 2025-06-05 03:23:14.184228 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-06-05 03:23:14.582996 | debian-bookworm -> localhost | ok 2025-06-05 03:23:14.590162 | 2025-06-05 03:23:14.590298 | TASK [validate-host : Collect information about the host] 2025-06-05 03:23:15.772145 | debian-bookworm | ok 2025-06-05 03:23:15.783176 | 2025-06-05 03:23:15.783313 | TASK [validate-host : Sanitize hostname] 2025-06-05 03:23:15.920512 | debian-bookworm | ok 2025-06-05 03:23:15.977449 | 2025-06-05 03:23:15.977605 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-06-05 03:23:16.665281 | debian-bookworm -> localhost | changed 2025-06-05 03:23:16.689904 | 2025-06-05 03:23:16.690351 | TASK [validate-host : Collect information about zuul worker] 2025-06-05 03:23:17.189909 | debian-bookworm | ok 2025-06-05 03:23:17.201253 | 2025-06-05 03:23:17.202724 | TASK [validate-host : Write out all zuul information for each host] 2025-06-05 03:23:17.786190 | debian-bookworm -> localhost | changed 2025-06-05 03:23:17.801909 | 2025-06-05 03:23:17.802059 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-06-05 03:23:18.086084 | debian-bookworm | ok 2025-06-05 03:23:18.094507 | 2025-06-05 03:23:18.094652 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-06-05 03:23:19.006478 | debian-bookworm | changed: 2025-06-05 03:23:19.006748 | debian-bookworm | cd+++++++++ src/ 2025-06-05 03:23:19.006790 | debian-bookworm | cd+++++++++ src/github.com/ 2025-06-05 03:23:19.006815 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-06-05 03:23:19.006857 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-06-05 03:23:19.006880 | debian-bookworm | Containerfile 2025-06-05 03:23:19.007170 | debian-bookworm | localhost | ok: Runtime: 0:00:00.008134 2025-06-05 03:25:06.701012 | 2025-06-05 03:25:06.701141 | TASK [upload-logs : Upload logs to log server] 2025-06-05 03:25:07.421258 | localhost | Output suppressed because no_log was given 2025-06-05 03:25:07.425343 | 2025-06-05 03:25:07.425534 | LOOP [upload-logs : Compress console log and json output] 2025-06-05 03:25:07.487465 | localhost | skipping: Conditional result was False 2025-06-05 03:25:07.493792 | localhost | skipping: Conditional result was False 2025-06-05 03:25:07.501996 | 2025-06-05 03:25:07.502244 | LOOP [upload-logs : Upload compressed console log and json output] 2025-06-05 03:25:07.557431 | localhost | skipping: Conditional result was False 2025-06-05 03:25:07.557791 | 2025-06-05 03:25:07.562989 | localhost | skipping: Conditional result was False 2025-06-05 03:25:07.569100 | 2025-06-05 03:25:07.569291 | LOOP [upload-logs : Upload console log and json output]