2025-05-30 21:51:50.572816 | Job console starting 2025-05-30 21:51:50.585049 | Updating git repos 2025-05-30 21:51:50.610270 | Cloning repos into workspace 2025-05-30 21:51:50.678500 | Restoring repo states 2025-05-30 21:51:50.685596 | Merging changes 2025-05-30 21:51:51.172784 | Checking out repos 2025-05-30 21:51:51.226179 | Preparing playbooks 2025-05-30 21:51:51.856614 | Running Ansible setup 2025-05-30 21:51:56.667864 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-30 21:51:57.843717 | 2025-05-30 21:51:57.843913 | PLAY [Base pre] 2025-05-30 21:51:57.883369 | 2025-05-30 21:51:57.883560 | TASK [Setup log path fact] 2025-05-30 21:51:57.928432 | debian-bookworm | ok 2025-05-30 21:51:57.963295 | 2025-05-30 21:51:57.963519 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-30 21:51:57.995932 | debian-bookworm | ok 2025-05-30 21:51:58.009970 | 2025-05-30 21:51:58.010122 | TASK [emit-job-header : Print job information] 2025-05-30 21:51:58.071158 | # Job Information 2025-05-30 21:51:58.071407 | Ansible Version: 2.16.14 2025-05-30 21:51:58.071444 | Job: container-image-cfg-cookiecutter-build 2025-05-30 21:51:58.071478 | Pipeline: check 2025-05-30 21:51:58.071503 | Executor: 521e9411259a 2025-05-30 21:51:58.071524 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/751 2025-05-30 21:51:58.071546 | Event ID: 293f95a0-3da0-11f0-8e0c-e78d18c14bbc 2025-05-30 21:51:58.076766 | 2025-05-30 21:51:58.076894 | LOOP [emit-job-header : Print node information] 2025-05-30 21:51:58.284950 | debian-bookworm | ok: 2025-05-30 21:51:58.285149 | debian-bookworm | # Node Information 2025-05-30 21:51:58.288904 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-30 21:51:58.288981 | debian-bookworm | Hostname: debian 2025-05-30 21:51:58.289011 | debian-bookworm | Username: zuul 2025-05-30 21:51:58.289035 | debian-bookworm | Distro: Debian 12.11 2025-05-30 21:51:58.289065 | debian-bookworm | Provider: regiocloud-a 2025-05-30 21:51:58.289088 | debian-bookworm | Region: 2025-05-30 21:51:58.289111 | debian-bookworm | Label: debian-bookworm 2025-05-30 21:51:58.289131 | debian-bookworm | Product Name: OpenStack Nova 2025-05-30 21:51:58.289207 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe24:51da 2025-05-30 21:51:58.303994 | 2025-05-30 21:51:58.304087 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-30 21:51:58.888624 | debian-bookworm -> localhost | changed 2025-05-30 21:51:58.901878 | 2025-05-30 21:51:58.901994 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-30 21:52:00.515484 | debian-bookworm -> localhost | changed 2025-05-30 21:52:00.524360 | 2025-05-30 21:52:00.524476 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-30 21:52:01.044869 | debian-bookworm -> localhost | ok 2025-05-30 21:52:01.050336 | 2025-05-30 21:52:01.050439 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-30 21:52:01.077691 | debian-bookworm | ok 2025-05-30 21:52:01.092934 | debian-bookworm | included: /var/lib/zuul/builds/708c22c20d6b49fab6d6eead208acecb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-30 21:52:01.098165 | 2025-05-30 21:52:01.098259 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-30 21:52:02.200738 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-30 21:52:02.200945 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/708c22c20d6b49fab6d6eead208acecb/work/708c22c20d6b49fab6d6eead208acecb_id_rsa 2025-05-30 21:52:02.200987 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/708c22c20d6b49fab6d6eead208acecb/work/708c22c20d6b49fab6d6eead208acecb_id_rsa.pub 2025-05-30 21:52:02.201015 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-30 21:52:02.201041 | debian-bookworm -> localhost | SHA256:taUth7TDdjmNBB5+LVZgxIawm+slkvkGOIdeLAAe1hQ zuul-build-sshkey 2025-05-30 21:52:02.201077 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-30 21:52:02.201100 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-30 21:52:02.201158 | debian-bookworm -> localhost | | oE. ..o++.. | 2025-05-30 21:52:02.201181 | debian-bookworm -> localhost | |.o . +.+oo | 2025-05-30 21:52:02.201202 | debian-bookworm -> localhost | |o.. . =.* . | 2025-05-30 21:52:02.201223 | debian-bookworm -> localhost | | .. * @ = | 2025-05-30 21:52:02.201245 | debian-bookworm -> localhost | | . + S X B . | 2025-05-30 21:52:02.201275 | debian-bookworm -> localhost | | = =o o = . | 2025-05-30 21:52:02.201313 | debian-bookworm -> localhost | | . =+.o . | 2025-05-30 21:52:02.201336 | debian-bookworm -> localhost | | . +.o | 2025-05-30 21:52:02.201358 | debian-bookworm -> localhost | | .o | 2025-05-30 21:52:02.201378 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-30 21:52:02.201448 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.504557 2025-05-30 21:52:02.213936 | 2025-05-30 21:52:02.214137 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-30 21:52:02.248217 | debian-bookworm | ok 2025-05-30 21:52:02.261025 | debian-bookworm | included: /var/lib/zuul/builds/708c22c20d6b49fab6d6eead208acecb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-30 21:52:02.269540 | 2025-05-30 21:52:02.269656 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-30 21:52:02.308588 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:52:02.323922 | 2025-05-30 21:52:02.324043 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-30 21:52:03.048219 | debian-bookworm | changed 2025-05-30 21:52:03.057689 | 2025-05-30 21:52:03.057805 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-30 21:52:03.313799 | debian-bookworm | ok 2025-05-30 21:52:03.319339 | 2025-05-30 21:52:03.319439 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-30 21:52:03.979670 | debian-bookworm | changed 2025-05-30 21:52:03.989782 | 2025-05-30 21:52:03.989900 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-30 21:52:04.710127 | debian-bookworm | changed 2025-05-30 21:52:04.715441 | 2025-05-30 21:52:04.715531 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-30 21:52:04.738739 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:52:04.744792 | 2025-05-30 21:52:04.744883 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-30 21:52:05.193878 | debian-bookworm -> localhost | changed 2025-05-30 21:52:05.206463 | 2025-05-30 21:52:05.206598 | TASK [add-build-sshkey : Add back temp key] 2025-05-30 21:52:05.630485 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/708c22c20d6b49fab6d6eead208acecb/work/708c22c20d6b49fab6d6eead208acecb_id_rsa (zuul-build-sshkey) 2025-05-30 21:52:05.630770 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035460 2025-05-30 21:52:05.646891 | 2025-05-30 21:52:05.647824 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-30 21:52:06.070290 | debian-bookworm | ok 2025-05-30 21:52:06.077188 | 2025-05-30 21:52:06.077320 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-30 21:52:06.115721 | debian-bookworm | skipping: Conditional result was False 2025-05-30 21:52:06.148576 | 2025-05-30 21:52:06.148719 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-30 21:52:06.635502 | debian-bookworm | ok 2025-05-30 21:52:06.664931 | 2025-05-30 21:52:06.665133 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-30 21:52:06.706019 | debian-bookworm | ok 2025-05-30 21:52:06.714048 | 2025-05-30 21:52:06.714533 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-30 21:52:07.036937 | debian-bookworm -> localhost | ok 2025-05-30 21:52:07.052148 | 2025-05-30 21:52:07.052355 | TASK [validate-host : Collect information about the host] 2025-05-30 21:52:08.196739 | debian-bookworm | ok 2025-05-30 21:52:08.212258 | 2025-05-30 21:52:08.212447 | TASK [validate-host : Sanitize hostname] 2025-05-30 21:52:08.358914 | debian-bookworm | ok 2025-05-30 21:52:08.434200 | 2025-05-30 21:52:08.434357 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-30 21:52:09.095981 | debian-bookworm -> localhost | changed 2025-05-30 21:52:09.102516 | 2025-05-30 21:52:09.102656 | TASK [validate-host : Collect information about zuul worker] 2025-05-30 21:52:09.531017 | debian-bookworm | ok 2025-05-30 21:52:09.537522 | 2025-05-30 21:52:09.537673 | TASK [validate-host : Write out all zuul information for each host] 2025-05-30 21:52:10.156616 | debian-bookworm -> localhost | changed 2025-05-30 21:52:10.167756 | 2025-05-30 21:52:10.167890 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-30 21:52:10.430864 | debian-bookworm | ok 2025-05-30 21:52:10.439029 | 2025-05-30 21:52:10.439161 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-30 21:52:11.412042 | debian-bookworm | changed: 2025-05-30 21:52:11.412291 | debian-bookworm | cd+++++++++ src/ 2025-05-30 21:52:11.412326 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-30 21:52:11.412351 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-30 21:52:11.412373 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-30 21:52:11.412412 | debian-bookworm | Containerfile 2025-05-30 21:52:11.412551 | debian-bookworm | localhost | ok: Runtime: 0:00:00.006854 2025-05-30 21:53:34.317869 | 2025-05-30 21:53:34.318091 | TASK [upload-logs : Upload logs to log server] 2025-05-30 21:53:34.920957 | localhost | Output suppressed because no_log was given 2025-05-30 21:53:34.925321 | 2025-05-30 21:53:34.925586 | LOOP [upload-logs : Compress console log and json output] 2025-05-30 21:53:34.979172 | localhost | skipping: Conditional result was False 2025-05-30 21:53:34.984208 | localhost | skipping: Conditional result was False 2025-05-30 21:53:34.999273 | 2025-05-30 21:53:34.999592 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-30 21:53:35.051534 | localhost | skipping: Conditional result was False 2025-05-30 21:53:35.052288 | 2025-05-30 21:53:35.054813 | localhost | skipping: Conditional result was False 2025-05-30 21:53:35.070356 | 2025-05-30 21:53:35.070629 | LOOP [upload-logs : Upload console log and json output]