2025-12-01 19:36:27.355805 | Job console starting 2025-12-01 19:36:27.366443 | Updating git repos 2025-12-01 19:36:27.399462 | Cloning repos into workspace 2025-12-01 19:36:27.526368 | Restoring repo states 2025-12-01 19:36:27.538113 | Merging changes 2025-12-01 19:36:28.191281 | Checking out repos 2025-12-01 19:36:28.269040 | Preparing playbooks 2025-12-01 19:36:29.194826 | Running Ansible setup 2025-12-01 19:36:34.841388 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-01 19:36:36.568608 | 2025-12-01 19:36:36.568788 | PLAY [Base pre] 2025-12-01 19:36:36.633756 | 2025-12-01 19:36:36.633945 | TASK [Setup log path fact] 2025-12-01 19:36:36.694575 | debian-bookworm | ok 2025-12-01 19:36:36.726747 | 2025-12-01 19:36:36.726957 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-01 19:36:36.852943 | debian-bookworm | ok 2025-12-01 19:36:36.882411 | 2025-12-01 19:36:36.882576 | TASK [emit-job-header : Print job information] 2025-12-01 19:36:36.984044 | # Job Information 2025-12-01 19:36:36.984334 | Ansible Version: 2.16.14 2025-12-01 19:36:36.984374 | Job: container-image-cfg-cookiecutter-build 2025-12-01 19:36:36.984416 | Pipeline: check 2025-12-01 19:36:36.984443 | Executor: 521e9411259a 2025-12-01 19:36:36.984464 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/798 2025-12-01 19:36:36.984487 | Event ID: e31eb6d0-ceec-11f0-8eb4-2c2e2c9b66e2 2025-12-01 19:36:36.990397 | 2025-12-01 19:36:36.990573 | LOOP [emit-job-header : Print node information] 2025-12-01 19:36:37.455755 | debian-bookworm | ok: 2025-12-01 19:36:37.456078 | debian-bookworm | # Node Information 2025-12-01 19:36:37.456121 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-01 19:36:37.456147 | debian-bookworm | Hostname: debian 2025-12-01 19:36:37.456169 | debian-bookworm | Username: zuul 2025-12-01 19:36:37.456190 | debian-bookworm | Distro: Debian 12.12 2025-12-01 19:36:37.456215 | debian-bookworm | Provider: regiocloud-a 2025-12-01 19:36:37.456237 | debian-bookworm | Region: 2025-12-01 19:36:37.456258 | debian-bookworm | Label: debian-bookworm 2025-12-01 19:36:37.456278 | debian-bookworm | Product Name: OpenStack Nova 2025-12-01 19:36:37.456297 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe04:5296 2025-12-01 19:36:37.484314 | 2025-12-01 19:36:37.484476 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-01 19:36:39.359615 | debian-bookworm -> localhost | changed 2025-12-01 19:36:39.367595 | 2025-12-01 19:36:39.367730 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-01 19:36:41.861133 | debian-bookworm -> localhost | changed 2025-12-01 19:36:41.875195 | 2025-12-01 19:36:41.875307 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-01 19:36:42.478480 | debian-bookworm -> localhost | ok 2025-12-01 19:36:42.484545 | 2025-12-01 19:36:42.484659 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-01 19:36:42.512725 | debian-bookworm | ok 2025-12-01 19:36:42.542575 | debian-bookworm | included: /var/lib/zuul/builds/f13a3ae8b37d46f7b7304ec84401f3ab/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-01 19:36:42.564505 | 2025-12-01 19:36:42.564618 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-01 19:36:44.751276 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-01 19:36:44.751441 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/f13a3ae8b37d46f7b7304ec84401f3ab/work/f13a3ae8b37d46f7b7304ec84401f3ab_id_rsa 2025-12-01 19:36:44.751473 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/f13a3ae8b37d46f7b7304ec84401f3ab/work/f13a3ae8b37d46f7b7304ec84401f3ab_id_rsa.pub 2025-12-01 19:36:44.751495 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-01 19:36:44.751516 | debian-bookworm -> localhost | SHA256:C4hVOzlQD8SV7syNLEnvF2S27XpDiFr3jS3Fy2GCcmw zuul-build-sshkey 2025-12-01 19:36:44.751542 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-01 19:36:44.751561 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-01 19:36:44.751578 | debian-bookworm -> localhost | | .+=... | 2025-12-01 19:36:44.751596 | debian-bookworm -> localhost | | o.=. | 2025-12-01 19:36:44.751612 | debian-bookworm -> localhost | | . =.. | 2025-12-01 19:36:44.751628 | debian-bookworm -> localhost | | o ..o. + | 2025-12-01 19:36:44.751645 | debian-bookworm -> localhost | | . ...BSO = . | 2025-12-01 19:36:44.751677 | debian-bookworm -> localhost | | o.@.E + = | 2025-12-01 19:36:44.751696 | debian-bookworm -> localhost | | =.= = O o | 2025-12-01 19:36:44.751713 | debian-bookworm -> localhost | | . . . B = | 2025-12-01 19:36:44.751730 | debian-bookworm -> localhost | | ..o o | 2025-12-01 19:36:44.751746 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-01 19:36:44.751791 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.314824 2025-12-01 19:36:44.760078 | 2025-12-01 19:36:44.760167 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-01 19:36:44.788753 | debian-bookworm | ok 2025-12-01 19:36:44.803026 | debian-bookworm | included: /var/lib/zuul/builds/f13a3ae8b37d46f7b7304ec84401f3ab/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-01 19:36:44.822057 | 2025-12-01 19:36:44.822164 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-01 19:36:44.870444 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:36:44.875439 | 2025-12-01 19:36:44.875526 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-01 19:36:45.624181 | debian-bookworm | changed 2025-12-01 19:36:45.628790 | 2025-12-01 19:36:45.628882 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-01 19:36:45.911923 | debian-bookworm | ok 2025-12-01 19:36:45.921441 | 2025-12-01 19:36:45.921559 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-01 19:36:46.709671 | debian-bookworm | changed 2025-12-01 19:36:46.731744 | 2025-12-01 19:36:46.731851 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-01 19:36:47.419614 | debian-bookworm | changed 2025-12-01 19:36:47.434443 | 2025-12-01 19:36:47.434560 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-01 19:36:47.467771 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:36:47.474449 | 2025-12-01 19:36:47.474561 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-01 19:36:47.924136 | debian-bookworm -> localhost | changed 2025-12-01 19:36:47.934617 | 2025-12-01 19:36:47.934728 | TASK [add-build-sshkey : Add back temp key] 2025-12-01 19:36:48.308517 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/f13a3ae8b37d46f7b7304ec84401f3ab/work/f13a3ae8b37d46f7b7304ec84401f3ab_id_rsa (zuul-build-sshkey) 2025-12-01 19:36:48.311015 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015599 2025-12-01 19:36:48.347445 | 2025-12-01 19:36:48.347562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-01 19:36:48.764120 | debian-bookworm | ok 2025-12-01 19:36:48.770607 | 2025-12-01 19:36:48.770717 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-01 19:36:48.793919 | debian-bookworm | skipping: Conditional result was False 2025-12-01 19:36:48.802616 | 2025-12-01 19:36:48.802714 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-01 19:36:49.222123 | debian-bookworm | ok 2025-12-01 19:36:49.253162 | 2025-12-01 19:36:49.253276 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-01 19:36:49.310080 | debian-bookworm | ok 2025-12-01 19:36:49.315385 | 2025-12-01 19:36:49.315499 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-01 19:36:49.695210 | debian-bookworm -> localhost | ok 2025-12-01 19:36:49.705190 | 2025-12-01 19:36:49.705294 | TASK [validate-host : Collect information about the host] 2025-12-01 19:36:50.908390 | debian-bookworm | ok 2025-12-01 19:36:50.927874 | 2025-12-01 19:36:50.928089 | TASK [validate-host : Sanitize hostname] 2025-12-01 19:36:51.066243 | debian-bookworm | ok 2025-12-01 19:36:51.177430 | 2025-12-01 19:36:51.177598 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-01 19:36:52.264155 | debian-bookworm -> localhost | changed 2025-12-01 19:36:52.283300 | 2025-12-01 19:36:52.283477 | TASK [validate-host : Collect information about zuul worker] 2025-12-01 19:36:52.924238 | debian-bookworm | ok 2025-12-01 19:36:52.939188 | 2025-12-01 19:36:52.939372 | TASK [validate-host : Write out all zuul information for each host] 2025-12-01 19:36:53.763136 | debian-bookworm -> localhost | changed 2025-12-01 19:36:53.790638 | 2025-12-01 19:36:53.790864 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-01 19:36:54.098678 | debian-bookworm | ok 2025-12-01 19:36:54.107645 | 2025-12-01 19:36:54.107813 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-01 19:36:55.005805 | debian-bookworm | changed: 2025-12-01 19:36:55.006116 | debian-bookworm | cd+++++++++ src/ 2025-12-01 19:36:55.006457 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-01 19:36:55.006487 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-01 19:36:55.006511 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2025-12-01 19:36:55.006533 | debian-bookworm | Containerfile 2025-12-01 19:36:55.007238 | debian-bookworm | localhost | ok: Runtime: 0:00:00.012719 2025-12-01 19:38:36.278061 | 2025-12-01 19:38:36.278263 | TASK [upload-logs : Upload logs to log server] 2025-12-01 19:38:36.899498 | localhost | Output suppressed because no_log was given 2025-12-01 19:38:36.901657 | 2025-12-01 19:38:36.901784 | LOOP [upload-logs : Compress console log and json output] 2025-12-01 19:38:36.967979 | localhost | skipping: Conditional result was False 2025-12-01 19:38:36.974388 | localhost | skipping: Conditional result was False 2025-12-01 19:38:36.981496 | 2025-12-01 19:38:36.981629 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-01 19:38:37.028363 | localhost | skipping: Conditional result was False 2025-12-01 19:38:37.028668 | 2025-12-01 19:38:37.033686 | localhost | skipping: Conditional result was False 2025-12-01 19:38:37.038449 | 2025-12-01 19:38:37.038582 | LOOP [upload-logs : Upload console log and json output]