2025-08-31 00:00:09.865837 | Job console starting 2025-08-31 00:00:09.876727 | Updating git repos 2025-08-31 00:00:09.904922 | Cloning repos into workspace 2025-08-31 00:00:09.961014 | Restoring repo states 2025-08-31 00:00:09.968760 | Merging changes 2025-08-31 00:00:09.968779 | Checking out repos 2025-08-31 00:00:10.050608 | Preparing playbooks 2025-08-31 00:00:10.817363 | Running Ansible setup 2025-08-31 00:00:17.435009 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-31 00:00:19.091416 | 2025-08-31 00:00:19.091549 | PLAY [Base pre] 2025-08-31 00:00:19.124893 | 2025-08-31 00:00:19.125021 | TASK [Setup log path fact] 2025-08-31 00:00:19.168588 | debian-bookworm | ok 2025-08-31 00:00:19.208980 | 2025-08-31 00:00:19.209114 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 00:00:19.244495 | debian-bookworm | ok 2025-08-31 00:00:19.268182 | 2025-08-31 00:00:19.268290 | TASK [emit-job-header : Print job information] 2025-08-31 00:00:19.351603 | # Job Information 2025-08-31 00:00:19.351779 | Ansible Version: 2.16.14 2025-08-31 00:00:19.351814 | Job: container-image-kolla-ansible-push-2024.1 2025-08-31 00:00:19.351847 | Pipeline: periodic-midnight 2025-08-31 00:00:19.351869 | Executor: 521e9411259a 2025-08-31 00:00:19.351890 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-08-31 00:00:19.351911 | Event ID: 81bd70fed8544fd6b27f7553239a71be 2025-08-31 00:00:19.360347 | 2025-08-31 00:00:19.360466 | LOOP [emit-job-header : Print node information] 2025-08-31 00:00:19.732023 | debian-bookworm | ok: 2025-08-31 00:00:19.732249 | debian-bookworm | # Node Information 2025-08-31 00:00:19.732286 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-31 00:00:19.732313 | debian-bookworm | Hostname: debian 2025-08-31 00:00:19.732336 | debian-bookworm | Username: zuul 2025-08-31 00:00:19.732357 | debian-bookworm | Distro: Debian 12.11 2025-08-31 00:00:19.732381 | debian-bookworm | Provider: regiocloud-a 2025-08-31 00:00:19.732402 | debian-bookworm | Region: 2025-08-31 00:00:19.732423 | debian-bookworm | Label: debian-bookworm 2025-08-31 00:00:19.732443 | debian-bookworm | Product Name: OpenStack Nova 2025-08-31 00:00:19.732462 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef1:d212 2025-08-31 00:00:19.751009 | 2025-08-31 00:00:19.751119 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-31 00:00:20.923043 | debian-bookworm -> localhost | changed 2025-08-31 00:00:20.930553 | 2025-08-31 00:00:20.930663 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-31 00:00:23.550581 | debian-bookworm -> localhost | changed 2025-08-31 00:00:23.559312 | 2025-08-31 00:00:23.559400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-31 00:00:24.177019 | debian-bookworm -> localhost | ok 2025-08-31 00:00:24.183219 | 2025-08-31 00:00:24.183315 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-31 00:00:24.230299 | debian-bookworm | ok 2025-08-31 00:00:24.255431 | debian-bookworm | included: /var/lib/zuul/builds/dda029c0648041e8a9734ad499938bbb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-31 00:00:24.282095 | 2025-08-31 00:00:24.282197 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-31 00:00:30.054769 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-31 00:00:30.054974 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/dda029c0648041e8a9734ad499938bbb/work/dda029c0648041e8a9734ad499938bbb_id_rsa 2025-08-31 00:00:30.055008 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/dda029c0648041e8a9734ad499938bbb/work/dda029c0648041e8a9734ad499938bbb_id_rsa.pub 2025-08-31 00:00:30.055031 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-31 00:00:30.055051 | debian-bookworm -> localhost | SHA256:o6XNC2Em4gdtZUB+Gmkee66KRssl6oPOpnrsSAysoO4 zuul-build-sshkey 2025-08-31 00:00:30.055079 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-31 00:00:30.055097 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-31 00:00:30.055115 | debian-bookworm -> localhost | | .o | 2025-08-31 00:00:30.055133 | debian-bookworm -> localhost | | . o | 2025-08-31 00:00:30.055150 | debian-bookworm -> localhost | | * + | 2025-08-31 00:00:30.055166 | debian-bookworm -> localhost | |. + O | 2025-08-31 00:00:30.055183 | debian-bookworm -> localhost | |o.o B = S | 2025-08-31 00:00:30.055204 | debian-bookworm -> localhost | |*+ = * B . | 2025-08-31 00:00:30.055221 | debian-bookworm -> localhost | |B+= . = o | 2025-08-31 00:00:30.055237 | debian-bookworm -> localhost | |*Oo. . . . | 2025-08-31 00:00:30.055254 | debian-bookworm -> localhost | |&E+.. . | 2025-08-31 00:00:30.055270 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-31 00:00:30.055312 | debian-bookworm -> localhost | ok: Runtime: 0:00:04.181144 2025-08-31 00:00:30.062032 | 2025-08-31 00:00:30.062115 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-31 00:00:30.099329 | debian-bookworm | ok 2025-08-31 00:00:30.113194 | debian-bookworm | included: /var/lib/zuul/builds/dda029c0648041e8a9734ad499938bbb/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-31 00:00:30.139212 | 2025-08-31 00:00:30.139305 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-31 00:00:30.184012 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:00:30.188798 | 2025-08-31 00:00:30.188884 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-31 00:00:31.133684 | debian-bookworm | changed 2025-08-31 00:00:31.137997 | 2025-08-31 00:00:31.138069 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-31 00:00:31.460765 | debian-bookworm | ok 2025-08-31 00:00:31.465262 | 2025-08-31 00:00:31.465345 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-31 00:00:32.315266 | debian-bookworm | changed 2025-08-31 00:00:32.320537 | 2025-08-31 00:00:32.320611 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-31 00:00:33.096353 | debian-bookworm | changed 2025-08-31 00:00:33.101778 | 2025-08-31 00:00:33.101855 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-31 00:00:33.135496 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:00:33.140394 | 2025-08-31 00:00:33.140469 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-31 00:00:33.965098 | debian-bookworm -> localhost | changed 2025-08-31 00:00:33.973758 | 2025-08-31 00:00:33.973845 | TASK [add-build-sshkey : Add back temp key] 2025-08-31 00:00:34.783810 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/dda029c0648041e8a9734ad499938bbb/work/dda029c0648041e8a9734ad499938bbb_id_rsa (zuul-build-sshkey) 2025-08-31 00:00:34.784000 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029094 2025-08-31 00:00:34.790185 | 2025-08-31 00:00:34.790269 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-31 00:00:35.462586 | debian-bookworm | ok 2025-08-31 00:00:35.466890 | 2025-08-31 00:00:35.466971 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-31 00:00:35.553613 | debian-bookworm | skipping: Conditional result was False 2025-08-31 00:00:35.562406 | 2025-08-31 00:00:35.563203 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-31 00:00:36.212696 | debian-bookworm | ok 2025-08-31 00:00:36.223840 | 2025-08-31 00:00:36.223926 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-31 00:00:36.267260 | debian-bookworm | ok 2025-08-31 00:00:36.271458 | 2025-08-31 00:00:36.271531 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-31 00:00:36.867166 | debian-bookworm -> localhost | ok 2025-08-31 00:00:36.872520 | 2025-08-31 00:00:36.872611 | TASK [validate-host : Collect information about the host] 2025-08-31 00:00:38.344413 | debian-bookworm | ok 2025-08-31 00:00:38.356547 | 2025-08-31 00:00:38.356648 | TASK [validate-host : Sanitize hostname] 2025-08-31 00:00:38.568988 | debian-bookworm | ok 2025-08-31 00:00:38.670330 | 2025-08-31 00:00:38.670428 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-31 00:00:39.520483 | debian-bookworm -> localhost | changed 2025-08-31 00:00:39.525217 | 2025-08-31 00:00:39.525298 | TASK [validate-host : Collect information about zuul worker] 2025-08-31 00:00:40.241325 | debian-bookworm | ok 2025-08-31 00:00:40.245239 | 2025-08-31 00:00:40.245316 | TASK [validate-host : Write out all zuul information for each host] 2025-08-31 00:00:41.323128 | debian-bookworm -> localhost | changed 2025-08-31 00:00:41.332156 | 2025-08-31 00:00:41.332349 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-31 00:00:41.613874 | debian-bookworm | ok 2025-08-31 00:00:41.619375 | 2025-08-31 00:00:41.619456 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-31 00:00:42.833022 | debian-bookworm | changed: 2025-08-31 00:00:42.833163 | debian-bookworm | cd+++++++++ src/ 2025-08-31 00:00:42.833192 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-31 00:00:42.833212 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-31 00:00:42.833231 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-08-31 00:00:42.833247 | debian-bookworm | Containerfile 2025-08-31 00:00:42.833365 | debian-bookworm | 2025-08-31 00:09:17.335631 | debian-bookworm | ERROR 2025-08-31 00:09:17.336060 | debian-bookworm | { 2025-08-31 00:09:17.336173 | debian-bookworm | "delta": "0:00:20.157634", 2025-08-31 00:09:17.336250 | debian-bookworm | "end": "2025-08-31 00:09:17.257543", 2025-08-31 00:09:17.336323 | debian-bookworm | "msg": "non-zero return code", 2025-08-31 00:09:17.336384 | debian-bookworm | "rc": 1, 2025-08-31 00:09:17.336442 | debian-bookworm | "start": "2025-08-31 00:08:57.099909" 2025-08-31 00:09:17.336526 | debian-bookworm | } failure 2025-08-31 00:09:17.350102 | 2025-08-31 00:09:17.351095 | PLAY RECAP 2025-08-31 00:09:17.351337 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-31 00:09:17.351387 | 2025-08-31 00:09:17.537137 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-08-31 00:09:17.538830 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-31 00:09:18.296309 | 2025-08-31 00:09:18.296592 | PLAY [Base post] 2025-08-31 00:09:18.310809 | 2025-08-31 00:09:18.310961 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-31 00:09:19.152461 | debian-bookworm | changed 2025-08-31 00:09:19.159123 | 2025-08-31 00:09:19.159253 | PLAY RECAP 2025-08-31 00:09:19.159316 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-31 00:09:19.159380 | 2025-08-31 00:09:19.284544 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-31 00:09:19.287164 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-31 00:09:20.057587 | 2025-08-31 00:09:20.057759 | PLAY [Base post-logs] 2025-08-31 00:09:20.068688 | 2025-08-31 00:09:20.068834 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-31 00:09:20.522831 | localhost | changed 2025-08-31 00:09:20.541763 | 2025-08-31 00:09:20.541961 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-31 00:09:20.581292 | localhost | ok 2025-08-31 00:09:20.588943 | 2025-08-31 00:09:20.589109 | TASK [Set zuul-log-path fact] 2025-08-31 00:09:20.608567 | localhost | ok 2025-08-31 00:09:20.623640 | 2025-08-31 00:09:20.623804 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-31 00:09:20.663924 | localhost | ok 2025-08-31 00:09:20.670347 | 2025-08-31 00:09:20.670570 | TASK [upload-logs : Create log directories] 2025-08-31 00:09:21.165710 | localhost | changed 2025-08-31 00:09:21.168620 | 2025-08-31 00:09:21.168734 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-31 00:09:21.729636 | localhost -> localhost | ok: Runtime: 0:00:00.007169 2025-08-31 00:09:21.736720 | 2025-08-31 00:09:21.736945 | TASK [upload-logs : Upload logs to log server] 2025-08-31 00:09:22.355093 | localhost | Output suppressed because no_log was given 2025-08-31 00:09:22.357680 | 2025-08-31 00:09:22.357809 | LOOP [upload-logs : Compress console log and json output] 2025-08-31 00:09:22.415616 | localhost | skipping: Conditional result was False 2025-08-31 00:09:22.422869 | localhost | skipping: Conditional result was False 2025-08-31 00:09:22.441072 | 2025-08-31 00:09:22.441307 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-31 00:09:22.500470 | localhost | skipping: Conditional result was False 2025-08-31 00:09:22.501373 | 2025-08-31 00:09:22.504601 | localhost | skipping: Conditional result was False 2025-08-31 00:09:22.515106 | 2025-08-31 00:09:22.515249 | LOOP [upload-logs : Upload console log and json output]