2026-04-01 22:01:47.759784 | Job console starting 2026-04-01 22:01:47.811123 | Updating git repos 2026-04-01 22:01:47.876434 | Cloning repos into workspace 2026-04-01 22:01:48.057741 | Restoring repo states 2026-04-01 22:01:48.077930 | Merging changes 2026-04-01 22:01:49.019038 | Checking out repos 2026-04-01 22:01:49.138032 | Preparing playbooks 2026-04-01 22:01:51.039566 | Running Ansible setup 2026-04-01 22:01:57.895691 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-04-01 22:01:59.571242 | 2026-04-01 22:01:59.571376 | PLAY [Base pre] 2026-04-01 22:01:59.612144 | 2026-04-01 22:01:59.612279 | TASK [Setup log path fact] 2026-04-01 22:01:59.660658 | debian-bookworm | ok 2026-04-01 22:01:59.694256 | 2026-04-01 22:01:59.694393 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-01 22:01:59.785994 | debian-bookworm | ok 2026-04-01 22:01:59.812317 | 2026-04-01 22:01:59.812429 | TASK [emit-job-header : Print job information] 2026-04-01 22:01:59.870675 | # Job Information 2026-04-01 22:01:59.870897 | Ansible Version: 2.16.14 2026-04-01 22:01:59.870937 | Job: container-image-cfg-cookiecutter-build 2026-04-01 22:01:59.870971 | Pipeline: check 2026-04-01 22:01:59.870994 | Executor: 521e9411259a 2026-04-01 22:01:59.871073 | Triggered by: https://github.com/osism/cfg-cookiecutter/pull/827 2026-04-01 22:01:59.871100 | Event ID: 59a99440-2e16-11f1-9872-b5a0bc149aa3 2026-04-01 22:01:59.875948 | 2026-04-01 22:01:59.876051 | LOOP [emit-job-header : Print node information] 2026-04-01 22:02:00.044728 | debian-bookworm | ok: 2026-04-01 22:02:00.044931 | debian-bookworm | # Node Information 2026-04-01 22:02:00.044962 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-04-01 22:02:00.044983 | debian-bookworm | Hostname: debian 2026-04-01 22:02:00.045001 | debian-bookworm | Username: zuul 2026-04-01 22:02:00.045114 | debian-bookworm | Distro: Debian 12.13 2026-04-01 22:02:00.045139 | debian-bookworm | Provider: regiocloud-a 2026-04-01 22:02:00.045157 | debian-bookworm | Region: 2026-04-01 22:02:00.045175 | debian-bookworm | Label: debian-bookworm 2026-04-01 22:02:00.045191 | debian-bookworm | Product Name: OpenStack Nova 2026-04-01 22:02:00.045208 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe65:20d3 2026-04-01 22:02:00.063661 | 2026-04-01 22:02:00.063764 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-01 22:02:01.114775 | debian-bookworm -> localhost | changed 2026-04-01 22:02:01.123579 | 2026-04-01 22:02:01.123672 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-01 22:02:03.215275 | debian-bookworm -> localhost | changed 2026-04-01 22:02:03.235607 | 2026-04-01 22:02:03.235702 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-01 22:02:04.031363 | debian-bookworm -> localhost | ok 2026-04-01 22:02:04.036693 | 2026-04-01 22:02:04.036792 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-01 22:02:04.093614 | debian-bookworm | ok 2026-04-01 22:02:04.133606 | debian-bookworm | included: /var/lib/zuul/builds/3c24eb473d824ff293494bbf6f126ba5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-01 22:02:04.151407 | 2026-04-01 22:02:04.151521 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-01 22:02:06.041659 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-04-01 22:02:06.041832 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3c24eb473d824ff293494bbf6f126ba5/work/3c24eb473d824ff293494bbf6f126ba5_id_rsa 2026-04-01 22:02:06.041866 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3c24eb473d824ff293494bbf6f126ba5/work/3c24eb473d824ff293494bbf6f126ba5_id_rsa.pub 2026-04-01 22:02:06.041890 | debian-bookworm -> localhost | The key fingerprint is: 2026-04-01 22:02:06.041911 | debian-bookworm -> localhost | SHA256:zMOELxXht2KvFaytjgmfI6XzA0xyRZNbxPpXF9g3dIU zuul-build-sshkey 2026-04-01 22:02:06.041940 | debian-bookworm -> localhost | The key's randomart image is: 2026-04-01 22:02:06.041960 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-04-01 22:02:06.041978 | debian-bookworm -> localhost | | .o++. o.o+| 2026-04-01 22:02:06.041996 | debian-bookworm -> localhost | | o+o. . E.o| 2026-04-01 22:02:06.042013 | debian-bookworm -> localhost | | ..++ . o.| 2026-04-01 22:02:06.042030 | debian-bookworm -> localhost | | . o oB o .. . | 2026-04-01 22:02:06.042046 | debian-bookworm -> localhost | | = ..S +. . | 2026-04-01 22:02:06.042065 | debian-bookworm -> localhost | | o .o.*.. | 2026-04-01 22:02:06.042082 | debian-bookworm -> localhost | | .+ ..+ | 2026-04-01 22:02:06.042098 | debian-bookworm -> localhost | | +oo+ + | 2026-04-01 22:02:06.042115 | debian-bookworm -> localhost | | +*++ | 2026-04-01 22:02:06.042132 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-04-01 22:02:06.042170 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.909499 2026-04-01 22:02:06.047254 | 2026-04-01 22:02:06.047339 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-01 22:02:06.077183 | debian-bookworm | ok 2026-04-01 22:02:06.087195 | debian-bookworm | included: /var/lib/zuul/builds/3c24eb473d824ff293494bbf6f126ba5/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-01 22:02:06.095071 | 2026-04-01 22:02:06.095149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-01 22:02:06.117196 | debian-bookworm | skipping: Conditional result was False 2026-04-01 22:02:06.123375 | 2026-04-01 22:02:06.123479 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-01 22:02:06.690250 | debian-bookworm | changed 2026-04-01 22:02:06.694726 | 2026-04-01 22:02:06.694802 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-01 22:02:06.937093 | debian-bookworm | ok 2026-04-01 22:02:06.941911 | 2026-04-01 22:02:06.942005 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-01 22:02:07.592264 | debian-bookworm | changed 2026-04-01 22:02:07.599283 | 2026-04-01 22:02:07.599379 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-01 22:02:08.338040 | debian-bookworm | changed 2026-04-01 22:02:08.343847 | 2026-04-01 22:02:08.343941 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-01 22:02:08.387142 | debian-bookworm | skipping: Conditional result was False 2026-04-01 22:02:08.394151 | 2026-04-01 22:02:08.394251 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-01 22:02:09.313079 | debian-bookworm -> localhost | changed 2026-04-01 22:02:09.327836 | 2026-04-01 22:02:09.327944 | TASK [add-build-sshkey : Add back temp key] 2026-04-01 22:02:09.901285 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3c24eb473d824ff293494bbf6f126ba5/work/3c24eb473d824ff293494bbf6f126ba5_id_rsa (zuul-build-sshkey) 2026-04-01 22:02:09.901474 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030139 2026-04-01 22:02:09.908342 | 2026-04-01 22:02:09.908428 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-01 22:02:10.608138 | debian-bookworm | ok 2026-04-01 22:02:10.612442 | 2026-04-01 22:02:10.612548 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-01 22:02:10.652115 | debian-bookworm | skipping: Conditional result was False 2026-04-01 22:02:10.661168 | 2026-04-01 22:02:10.661252 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-04-01 22:02:11.095051 | debian-bookworm | ok 2026-04-01 22:02:11.124553 | 2026-04-01 22:02:11.124658 | TASK [validate-host : Define zuul_info_dir fact] 2026-04-01 22:02:11.194041 | debian-bookworm | ok 2026-04-01 22:02:11.199042 | 2026-04-01 22:02:11.199139 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-04-01 22:02:11.785105 | debian-bookworm -> localhost | ok 2026-04-01 22:02:11.791509 | 2026-04-01 22:02:11.791604 | TASK [validate-host : Collect information about the host] 2026-04-01 22:02:13.123633 | debian-bookworm | ok 2026-04-01 22:02:13.141111 | 2026-04-01 22:02:13.141213 | TASK [validate-host : Sanitize hostname] 2026-04-01 22:02:13.311423 | debian-bookworm | ok 2026-04-01 22:02:13.382296 | 2026-04-01 22:02:13.382401 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-04-01 22:02:14.646012 | debian-bookworm -> localhost | changed 2026-04-01 22:02:14.660008 | 2026-04-01 22:02:14.660107 | TASK [validate-host : Collect information about zuul worker] 2026-04-01 22:02:15.213538 | debian-bookworm | ok 2026-04-01 22:02:15.218068 | 2026-04-01 22:02:15.218166 | TASK [validate-host : Write out all zuul information for each host] 2026-04-01 22:02:16.249990 | debian-bookworm -> localhost | changed 2026-04-01 22:02:16.257440 | 2026-04-01 22:02:16.257538 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-04-01 22:02:16.588725 | debian-bookworm | ok 2026-04-01 22:02:16.593128 | 2026-04-01 22:02:16.593207 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-04-01 22:02:17.827033 | debian-bookworm | changed: 2026-04-01 22:02:17.827185 | debian-bookworm | cd+++++++++ src/ 2026-04-01 22:02:17.827214 | debian-bookworm | cd+++++++++ src/github.com/ 2026-04-01 22:02:17.827234 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-04-01 22:02:17.827252 | debian-bookworm | cd+++++++++ src/github.com/osism/cfg-cookiecutter/ 2026-04-01 22:02:17.827268 | debian-bookworm | Containerfile 2026-04-01 22:02:17.827376 | debian-bookworm | localhost | ok: Runtime: 0:00:00.004366 2026-04-01 22:03:58.278319 | 2026-04-01 22:03:58.278519 | TASK [upload-logs : Upload logs to log server] 2026-04-01 22:03:58.903409 | localhost | Output suppressed because no_log was given 2026-04-01 22:03:58.905715 | 2026-04-01 22:03:58.905861 | LOOP [upload-logs : Compress console log and json output] 2026-04-01 22:03:58.971270 | localhost | skipping: Conditional result was False 2026-04-01 22:03:58.977680 | localhost | skipping: Conditional result was False 2026-04-01 22:03:58.984314 | 2026-04-01 22:03:58.984460 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-01 22:03:59.032816 | localhost | skipping: Conditional result was False 2026-04-01 22:03:59.033118 | 2026-04-01 22:03:59.037921 | localhost | skipping: Conditional result was False 2026-04-01 22:03:59.041868 | 2026-04-01 22:03:59.042010 | LOOP [upload-logs : Upload console log and json output]