2026-03-25 01:34:44.287464 | Job console starting 2026-03-25 01:34:44.299005 | Updating git repos 2026-03-25 01:34:44.317037 | Cloning repos into workspace 2026-03-25 01:34:44.418635 | Restoring repo states 2026-03-25 01:34:44.426445 | Merging changes 2026-03-25 01:34:44.906680 | Checking out repos 2026-03-25 01:34:44.948497 | Preparing playbooks 2026-03-25 01:34:45.619142 | Running Ansible setup 2026-03-25 01:34:49.954197 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 01:34:50.933483 | 2026-03-25 01:34:50.933658 | PLAY [Base pre] 2026-03-25 01:34:50.949895 | 2026-03-25 01:34:50.950033 | TASK [Setup log path fact] 2026-03-25 01:34:50.979604 | debian-bookworm | ok 2026-03-25 01:34:50.994791 | 2026-03-25 01:34:50.994985 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 01:34:51.036882 | debian-bookworm | ok 2026-03-25 01:34:51.047062 | 2026-03-25 01:34:51.047193 | TASK [emit-job-header : Print job information] 2026-03-25 01:34:51.086606 | # Job Information 2026-03-25 01:34:51.086820 | Ansible Version: 2.16.14 2026-03-25 01:34:51.086882 | Job: container-image-cfg-cookiecutter-build 2026-03-25 01:34:51.086917 | Pipeline: check 2026-03-25 01:34:51.086940 | Executor: 521e9411259a 2026-03-25 01:34:51.086961 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/819 2026-03-25 01:34:51.086982 | Event ID: ac8c4360-27ea-11f1-8457-4efeb00c9b4e 2026-03-25 01:34:51.092111 | 2026-03-25 01:34:51.092232 | LOOP [emit-job-header : Print node information] 2026-03-25 01:34:51.287661 | debian-bookworm | ok: 2026-03-25 01:34:51.287964 | debian-bookworm | # Node Information 2026-03-25 01:34:51.288004 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-25 01:34:51.288031 | debian-bookworm | Hostname: debian 2026-03-25 01:34:51.288053 | debian-bookworm | Username: zuul 2026-03-25 01:34:51.288075 | debian-bookworm | Distro: Debian 12.13 2026-03-25 01:34:51.288100 | debian-bookworm | Provider: regiocloud-a 2026-03-25 01:34:51.288121 | debian-bookworm | Region: 2026-03-25 01:34:51.288143 | debian-bookworm | Label: debian-bookworm 2026-03-25 01:34:51.288163 | debian-bookworm | Product Name: OpenStack Nova 2026-03-25 01:34:51.288183 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec5:665e 2026-03-25 01:34:51.308855 | 2026-03-25 01:34:51.308999 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-25 01:34:51.990162 | debian-bookworm -> localhost | changed 2026-03-25 01:34:51.997209 | 2026-03-25 01:34:51.997311 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-25 01:34:53.315353 | debian-bookworm -> localhost | changed 2026-03-25 01:34:53.325851 | 2026-03-25 01:34:53.325958 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-25 01:34:53.665441 | debian-bookworm -> localhost | ok 2026-03-25 01:34:53.671761 | 2026-03-25 01:34:53.671876 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-25 01:34:53.712898 | debian-bookworm | ok 2026-03-25 01:34:53.735373 | debian-bookworm | included: /var/lib/zuul/builds/c5c8afbb0b744165950b50029fc4080c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-25 01:34:53.741245 | 2026-03-25 01:34:53.741332 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-25 01:34:54.907259 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-25 01:34:54.907451 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c5c8afbb0b744165950b50029fc4080c/work/c5c8afbb0b744165950b50029fc4080c_id_rsa 2026-03-25 01:34:54.907491 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c5c8afbb0b744165950b50029fc4080c/work/c5c8afbb0b744165950b50029fc4080c_id_rsa.pub 2026-03-25 01:34:54.907517 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-25 01:34:54.907542 | debian-bookworm -> localhost | SHA256:JzULGHDBw8keI+F+Got3wuxBbB91CqNQa2nXwgiY3qk zuul-build-sshkey 2026-03-25 01:34:54.907577 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-25 01:34:54.907600 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-25 01:34:54.907622 | debian-bookworm -> localhost | | o. +*+o | 2026-03-25 01:34:54.907644 | debian-bookworm -> localhost | |o +.*O+ | 2026-03-25 01:34:54.907665 | debian-bookworm -> localhost | |. o OoB++ + | 2026-03-25 01:34:54.907684 | debian-bookworm -> localhost | | . O o.= = o | 2026-03-25 01:34:54.907704 | debian-bookworm -> localhost | | . B o S o | 2026-03-25 01:34:54.907729 | debian-bookworm -> localhost | | E * * . o | 2026-03-25 01:34:54.907780 | debian-bookworm -> localhost | | . O o | 2026-03-25 01:34:54.907802 | debian-bookworm -> localhost | | o + | 2026-03-25 01:34:54.907823 | debian-bookworm -> localhost | | . | 2026-03-25 01:34:54.907844 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-25 01:34:54.907894 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.570767 2026-03-25 01:34:54.914227 | 2026-03-25 01:34:54.914323 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-25 01:34:54.946594 | debian-bookworm | ok 2026-03-25 01:34:54.957886 | debian-bookworm | included: /var/lib/zuul/builds/c5c8afbb0b744165950b50029fc4080c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-25 01:34:54.966697 | 2026-03-25 01:34:54.966790 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-25 01:34:54.981456 | debian-bookworm | skipping: Conditional result was False 2026-03-25 01:34:54.987507 | 2026-03-25 01:34:54.987601 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-25 01:34:55.797817 | debian-bookworm | changed 2026-03-25 01:34:55.807432 | 2026-03-25 01:34:55.808456 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-25 01:34:56.059960 | debian-bookworm | ok 2026-03-25 01:34:56.068037 | 2026-03-25 01:34:56.068149 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-25 01:34:56.704860 | debian-bookworm | changed 2026-03-25 01:34:56.711917 | 2026-03-25 01:34:56.712014 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-25 01:34:57.323856 | debian-bookworm | changed 2026-03-25 01:34:57.331449 | 2026-03-25 01:34:57.331624 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-25 01:34:57.359707 | debian-bookworm | skipping: Conditional result was False 2026-03-25 01:34:57.369669 | 2026-03-25 01:34:57.369884 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-25 01:34:57.829725 | debian-bookworm -> localhost | changed 2026-03-25 01:34:57.840650 | 2026-03-25 01:34:57.840763 | TASK [add-build-sshkey : Add back temp key] 2026-03-25 01:34:58.191963 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c5c8afbb0b744165950b50029fc4080c/work/c5c8afbb0b744165950b50029fc4080c_id_rsa (zuul-build-sshkey) 2026-03-25 01:34:58.192187 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019695 2026-03-25 01:34:58.199952 | 2026-03-25 01:34:58.200040 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-25 01:34:58.576900 | debian-bookworm | ok 2026-03-25 01:34:58.583333 | 2026-03-25 01:34:58.583439 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-25 01:34:58.616853 | debian-bookworm | skipping: Conditional result was False 2026-03-25 01:34:58.636530 | 2026-03-25 01:34:58.636651 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-25 01:34:59.019158 | debian-bookworm | ok 2026-03-25 01:34:59.031478 | 2026-03-25 01:34:59.031610 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-25 01:34:59.077346 | debian-bookworm | ok 2026-03-25 01:34:59.085674 | 2026-03-25 01:34:59.085861 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-25 01:34:59.429726 | debian-bookworm -> localhost | ok 2026-03-25 01:34:59.445982 | 2026-03-25 01:34:59.446214 | TASK [validate-host : Collect information about the host] 2026-03-25 01:35:00.570452 | debian-bookworm | ok 2026-03-25 01:35:00.589711 | 2026-03-25 01:35:00.589907 | TASK [validate-host : Sanitize hostname] 2026-03-25 01:35:00.709493 | debian-bookworm | ok 2026-03-25 01:35:00.773905 | 2026-03-25 01:35:00.774075 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-25 01:35:01.422055 | debian-bookworm -> localhost | changed 2026-03-25 01:35:01.439880 | 2026-03-25 01:35:01.440217 | TASK [validate-host : Collect information about zuul worker] 2026-03-25 01:35:01.867255 | debian-bookworm | ok 2026-03-25 01:35:01.878447 | 2026-03-25 01:35:01.878707 | TASK [validate-host : Write out all zuul information for each host] 2026-03-25 01:35:02.510242 | debian-bookworm -> localhost | changed 2026-03-25 01:35:02.531465 | 2026-03-25 01:35:02.531638 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-25 01:35:02.814121 | debian-bookworm | ok 2026-03-25 01:35:02.824717 | 2026-03-25 01:35:02.824919 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-25 01:35:03.809231 | debian-bookworm | changed: 2026-03-25 01:35:03.809509 | debian-bookworm | cd+++++++++ src/ 2026-03-25 01:35:03.809546 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-25 01:35:03.809571 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-25 01:35:03.809592 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-03-25 01:35:03.809613 | debian-bookworm | Containerfile 2026-03-25 01:35:03.809766 | debian-bookworm | localhost | ok: Runtime: 0:00:00.005113 2026-03-25 01:36:40.793704 | 2026-03-25 01:36:40.793836 | TASK [upload-logs : Upload logs to log server] 2026-03-25 01:36:41.389640 | localhost | Output suppressed because no_log was given 2026-03-25 01:36:41.392502 | 2026-03-25 01:36:41.392629 | LOOP [upload-logs : Compress console log and json output] 2026-03-25 01:36:41.458015 | localhost | skipping: Conditional result was False 2026-03-25 01:36:41.465027 | localhost | skipping: Conditional result was False 2026-03-25 01:36:41.471780 | 2026-03-25 01:36:41.471894 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-25 01:36:41.523835 | localhost | skipping: Conditional result was False 2026-03-25 01:36:41.524200 | 2026-03-25 01:36:41.528208 | localhost | skipping: Conditional result was False 2026-03-25 01:36:41.539595 | 2026-03-25 01:36:41.539721 | LOOP [upload-logs : Upload console log and json output]