2025-05-17 19:04:24.841104 | Job console starting 2025-05-17 19:04:24.851573 | Updating git repos 2025-05-17 19:04:24.884175 | Cloning repos into workspace 2025-05-17 19:04:24.983773 | Restoring repo states 2025-05-17 19:04:24.997244 | Merging changes 2025-05-17 19:04:25.626112 | Checking out repos 2025-05-17 19:04:25.697382 | Preparing playbooks 2025-05-17 19:04:26.843615 | Running Ansible setup 2025-05-17 19:04:33.152450 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-05-17 19:04:34.341443 | 2025-05-17 19:04:34.341634 | PLAY [Base pre] 2025-05-17 19:04:34.379023 | 2025-05-17 19:04:34.379178 | TASK [Setup log path fact] 2025-05-17 19:04:34.423474 | debian-bookworm | ok 2025-05-17 19:04:34.457225 | 2025-05-17 19:04:34.457391 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-05-17 19:04:34.513020 | debian-bookworm | ok 2025-05-17 19:04:34.532698 | 2025-05-17 19:04:34.532836 | TASK [emit-job-header : Print job information] 2025-05-17 19:04:34.598916 | # Job Information 2025-05-17 19:04:34.599103 | Ansible Version: 2.16.14 2025-05-17 19:04:34.599138 | Job: container-image-cfg-cookiecutter-build 2025-05-17 19:04:34.599172 | Pipeline: check 2025-05-17 19:04:34.599196 | Executor: 521e9411259a 2025-05-17 19:04:34.599232 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/742 2025-05-17 19:04:34.599356 | Event ID: 7dba3c10-3351-11f0-91ea-2381a9d44029 2025-05-17 19:04:34.606276 | 2025-05-17 19:04:34.606669 | LOOP [emit-job-header : Print node information] 2025-05-17 19:04:34.714955 | debian-bookworm | ok: 2025-05-17 19:04:34.720732 | debian-bookworm | # Node Information 2025-05-17 19:04:34.720844 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-05-17 19:04:34.720875 | debian-bookworm | Hostname: debian 2025-05-17 19:04:34.720900 | debian-bookworm | Username: zuul 2025-05-17 19:04:34.720921 | debian-bookworm | Distro: Debian 12.11 2025-05-17 19:04:34.720946 | debian-bookworm | Provider: regiocloud-a 2025-05-17 19:04:34.720967 | debian-bookworm | Region: 2025-05-17 19:04:34.720989 | debian-bookworm | Label: debian-bookworm 2025-05-17 19:04:34.721009 | debian-bookworm | Product Name: OpenStack Nova 2025-05-17 19:04:34.721029 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe74:6431 2025-05-17 19:04:34.740539 | 2025-05-17 19:04:34.740686 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-05-17 19:04:35.413926 | debian-bookworm -> localhost | changed 2025-05-17 19:04:35.422587 | 2025-05-17 19:04:35.422757 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-05-17 19:04:36.885171 | debian-bookworm -> localhost | changed 2025-05-17 19:04:36.896810 | 2025-05-17 19:04:36.896948 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-05-17 19:04:37.215487 | debian-bookworm -> localhost | ok 2025-05-17 19:04:37.234404 | 2025-05-17 19:04:37.234637 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-05-17 19:04:37.268358 | debian-bookworm | ok 2025-05-17 19:04:37.292967 | debian-bookworm | included: /var/lib/zuul/builds/e57543bb24ef40868fa981aff507e4f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-05-17 19:04:37.302071 | 2025-05-17 19:04:37.302200 | TASK [add-build-sshkey : Create Temp SSH key] 2025-05-17 19:04:38.597417 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-05-17 19:04:38.598040 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e57543bb24ef40868fa981aff507e4f4/work/e57543bb24ef40868fa981aff507e4f4_id_rsa 2025-05-17 19:04:38.598159 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e57543bb24ef40868fa981aff507e4f4/work/e57543bb24ef40868fa981aff507e4f4_id_rsa.pub 2025-05-17 19:04:38.598311 | debian-bookworm -> localhost | The key fingerprint is: 2025-05-17 19:04:38.598349 | debian-bookworm -> localhost | SHA256:VaT5XIoz7gtBolhhhTMqC01G/lCE8HEU2gVUFzE/0G8 zuul-build-sshkey 2025-05-17 19:04:38.598393 | debian-bookworm -> localhost | The key's randomart image is: 2025-05-17 19:04:38.598479 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-05-17 19:04:38.598607 | debian-bookworm -> localhost | |.oo=@*+ *+ .o | 2025-05-17 19:04:38.598648 | debian-bookworm -> localhost | | o+B+o . +.+ | 2025-05-17 19:04:38.598676 | debian-bookworm -> localhost | | +=.oo. . *. . | 2025-05-17 19:04:38.598703 | debian-bookworm -> localhost | |o o= . o . =Eo | 2025-05-17 19:04:38.598742 | debian-bookworm -> localhost | |.o. o S +.+ | 2025-05-17 19:04:38.598920 | debian-bookworm -> localhost | |. o o | 2025-05-17 19:04:38.598962 | debian-bookworm -> localhost | | . . | 2025-05-17 19:04:38.598991 | debian-bookworm -> localhost | | o | 2025-05-17 19:04:38.599021 | debian-bookworm -> localhost | | o. | 2025-05-17 19:04:38.599048 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-05-17 19:04:38.599136 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.757163 2025-05-17 19:04:38.618458 | 2025-05-17 19:04:38.618755 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-05-17 19:04:38.650269 | debian-bookworm | ok 2025-05-17 19:04:38.664820 | debian-bookworm | included: /var/lib/zuul/builds/e57543bb24ef40868fa981aff507e4f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-05-17 19:04:38.678185 | 2025-05-17 19:04:38.678632 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-05-17 19:04:38.703248 | debian-bookworm | skipping: Conditional result was False 2025-05-17 19:04:38.716778 | 2025-05-17 19:04:38.717101 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-05-17 19:04:39.361979 | debian-bookworm | changed 2025-05-17 19:04:39.370083 | 2025-05-17 19:04:39.370202 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-05-17 19:04:39.686604 | debian-bookworm | ok 2025-05-17 19:04:39.696825 | 2025-05-17 19:04:39.696954 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-05-17 19:04:40.423489 | debian-bookworm | changed 2025-05-17 19:04:40.441834 | 2025-05-17 19:04:40.442085 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-05-17 19:04:41.150195 | debian-bookworm | changed 2025-05-17 19:04:41.155798 | 2025-05-17 19:04:41.155907 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-05-17 19:04:41.179736 | debian-bookworm | skipping: Conditional result was False 2025-05-17 19:04:41.187557 | 2025-05-17 19:04:41.187706 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-05-17 19:04:41.680360 | debian-bookworm -> localhost | changed 2025-05-17 19:04:41.694935 | 2025-05-17 19:04:41.695068 | TASK [add-build-sshkey : Add back temp key] 2025-05-17 19:04:42.289842 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e57543bb24ef40868fa981aff507e4f4/work/e57543bb24ef40868fa981aff507e4f4_id_rsa (zuul-build-sshkey) 2025-05-17 19:04:42.290572 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.014928 2025-05-17 19:04:42.321458 | 2025-05-17 19:04:42.321686 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-05-17 19:04:42.801453 | debian-bookworm | ok 2025-05-17 19:04:42.810870 | 2025-05-17 19:04:42.811035 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-05-17 19:04:42.899534 | debian-bookworm | skipping: Conditional result was False 2025-05-17 19:04:42.915895 | 2025-05-17 19:04:42.916037 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-05-17 19:04:43.392294 | debian-bookworm | ok 2025-05-17 19:04:43.415199 | 2025-05-17 19:04:43.415344 | TASK [validate-host : Define zuul_info_dir fact] 2025-05-17 19:04:43.469198 | debian-bookworm | ok 2025-05-17 19:04:43.478166 | 2025-05-17 19:04:43.478860 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-05-17 19:04:43.904796 | debian-bookworm -> localhost | ok 2025-05-17 19:04:43.914767 | 2025-05-17 19:04:43.915019 | TASK [validate-host : Collect information about the host] 2025-05-17 19:04:45.179242 | debian-bookworm | ok 2025-05-17 19:04:45.198093 | 2025-05-17 19:04:45.198276 | TASK [validate-host : Sanitize hostname] 2025-05-17 19:04:45.311367 | debian-bookworm | ok 2025-05-17 19:04:45.352833 | 2025-05-17 19:04:45.352965 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-05-17 19:04:45.985195 | debian-bookworm -> localhost | changed 2025-05-17 19:04:46.023414 | 2025-05-17 19:04:46.027061 | TASK [validate-host : Collect information about zuul worker] 2025-05-17 19:04:46.521263 | debian-bookworm | ok 2025-05-17 19:04:46.528245 | 2025-05-17 19:04:46.528752 | TASK [validate-host : Write out all zuul information for each host] 2025-05-17 19:04:47.851801 | debian-bookworm -> localhost | changed 2025-05-17 19:04:47.865869 | 2025-05-17 19:04:47.866716 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-05-17 19:04:48.216819 | debian-bookworm | ok 2025-05-17 19:04:48.225346 | 2025-05-17 19:04:48.225479 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-05-17 19:04:49.495611 | debian-bookworm | changed: 2025-05-17 19:04:49.495816 | debian-bookworm | cd+++++++++ src/ 2025-05-17 19:04:49.495849 | debian-bookworm | cd+++++++++ src/github.com/ 2025-05-17 19:04:49.495873 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-05-17 19:04:49.495894 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-05-17 19:04:49.495913 | debian-bookworm | Containerfile 2025-05-17 19:04:49.496042 | debian-bookworm | localhost | ok: Runtime: 0:00:00.013010 2025-05-17 19:06:11.097539 | 2025-05-17 19:06:11.097666 | TASK [upload-logs : Upload logs to log server] 2025-05-17 19:06:11.688199 | localhost | Output suppressed because no_log was given 2025-05-17 19:06:11.692968 | 2025-05-17 19:06:11.693517 | LOOP [upload-logs : Compress console log and json output] 2025-05-17 19:06:11.765604 | localhost | skipping: Conditional result was False 2025-05-17 19:06:11.772340 | localhost | skipping: Conditional result was False 2025-05-17 19:06:11.786625 | 2025-05-17 19:06:11.787372 | LOOP [upload-logs : Upload compressed console log and json output] 2025-05-17 19:06:11.850768 | localhost | skipping: Conditional result was False 2025-05-17 19:06:11.851247 | 2025-05-17 19:06:11.856804 | localhost | skipping: Conditional result was False 2025-05-17 19:06:11.864213 | 2025-05-17 19:06:11.864334 | LOOP [upload-logs : Upload console log and json output]