2025-09-28 12:07:51.401001 | Job console starting 2025-09-28 12:07:51.417980 | Updating git repos 2025-09-28 12:07:51.442340 | Cloning repos into workspace 2025-09-28 12:07:51.502202 | Restoring repo states 2025-09-28 12:07:51.516910 | Merging changes 2025-09-28 12:07:51.516925 | Checking out repos 2025-09-28 12:07:51.595015 | Preparing playbooks 2025-09-28 12:07:52.227946 | Running Ansible setup 2025-09-28 12:07:56.405915 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 12:07:57.183206 | 2025-09-28 12:07:57.183366 | PLAY [Base pre] 2025-09-28 12:07:57.202448 | 2025-09-28 12:07:57.202604 | TASK [Setup log path fact] 2025-09-28 12:07:57.231751 | debian-bookworm | ok 2025-09-28 12:07:57.247043 | 2025-09-28 12:07:57.247187 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 12:07:57.277241 | debian-bookworm | ok 2025-09-28 12:07:57.287585 | 2025-09-28 12:07:57.287771 | TASK [emit-job-header : Print job information] 2025-09-28 12:07:57.329919 | # Job Information 2025-09-28 12:07:57.330144 | Ansible Version: 2.16.14 2025-09-28 12:07:57.330198 | Job: container-image-kolla-ansible-push-2024.1 2025-09-28 12:07:57.330250 | Pipeline: post 2025-09-28 12:07:57.330284 | Executor: 521e9411259a 2025-09-28 12:07:57.330314 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/7721685a520a230598fb6d88e8c5a4ca9f0180bd 2025-09-28 12:07:57.330348 | Event ID: bde4d612-9c63-11f0-9692-31c526073aba 2025-09-28 12:07:57.336869 | 2025-09-28 12:07:57.336993 | LOOP [emit-job-header : Print node information] 2025-09-28 12:07:57.448642 | debian-bookworm | ok: 2025-09-28 12:07:57.448837 | debian-bookworm | # Node Information 2025-09-28 12:07:57.448872 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 12:07:57.448897 | debian-bookworm | Hostname: debian 2025-09-28 12:07:57.448917 | debian-bookworm | Username: zuul 2025-09-28 12:07:57.448938 | debian-bookworm | Distro: Debian 12.12 2025-09-28 12:07:57.448961 | debian-bookworm | Provider: regiocloud-a 2025-09-28 12:07:57.448981 | debian-bookworm | Region: 2025-09-28 12:07:57.449002 | debian-bookworm | Label: debian-bookworm 2025-09-28 12:07:57.449022 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 12:07:57.449041 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec8:14e4 2025-09-28 12:07:57.462086 | 2025-09-28 12:07:57.462220 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 12:07:57.953190 | debian-bookworm -> localhost | changed 2025-09-28 12:07:57.960877 | 2025-09-28 12:07:57.961005 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 12:07:59.026081 | debian-bookworm -> localhost | changed 2025-09-28 12:07:59.037694 | 2025-09-28 12:07:59.037821 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 12:07:59.307209 | debian-bookworm -> localhost | ok 2025-09-28 12:07:59.314208 | 2025-09-28 12:07:59.314334 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 12:07:59.343169 | debian-bookworm | ok 2025-09-28 12:07:59.361157 | debian-bookworm | included: /var/lib/zuul/builds/30d994bdf02145c89c4e0387931abc58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 12:07:59.368317 | 2025-09-28 12:07:59.368465 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 12:08:00.850503 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 12:08:00.850909 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/30d994bdf02145c89c4e0387931abc58/work/30d994bdf02145c89c4e0387931abc58_id_rsa 2025-09-28 12:08:00.850988 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/30d994bdf02145c89c4e0387931abc58/work/30d994bdf02145c89c4e0387931abc58_id_rsa.pub 2025-09-28 12:08:00.851036 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 12:08:00.851078 | debian-bookworm -> localhost | SHA256:j282//QXuq1xF8Hp+Ht/ioyW9bazqLtHPVBT+uHPGEY zuul-build-sshkey 2025-09-28 12:08:00.851131 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 12:08:00.851171 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 12:08:00.851209 | debian-bookworm -> localhost | | ..| 2025-09-28 12:08:00.851247 | debian-bookworm -> localhost | | +..| 2025-09-28 12:08:00.851283 | debian-bookworm -> localhost | | .E* | 2025-09-28 12:08:00.851318 | debian-bookworm -> localhost | | ..+.o| 2025-09-28 12:08:00.851351 | debian-bookworm -> localhost | | S +o+.| 2025-09-28 12:08:00.851457 | debian-bookworm -> localhost | | o o.+=o| 2025-09-28 12:08:00.851497 | debian-bookworm -> localhost | | . .+ o++=| 2025-09-28 12:08:00.851531 | debian-bookworm -> localhost | | .*o.=B.*| 2025-09-28 12:08:00.851568 | debian-bookworm -> localhost | | +*B==BBB| 2025-09-28 12:08:00.851602 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 12:08:00.851701 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.994164 2025-09-28 12:08:00.864411 | 2025-09-28 12:08:00.864532 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 12:08:00.896429 | debian-bookworm | ok 2025-09-28 12:08:00.907690 | debian-bookworm | included: /var/lib/zuul/builds/30d994bdf02145c89c4e0387931abc58/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 12:08:00.916923 | 2025-09-28 12:08:00.917021 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 12:08:00.940858 | debian-bookworm | skipping: Conditional result was False 2025-09-28 12:08:00.948148 | 2025-09-28 12:08:00.948256 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 12:08:01.602684 | debian-bookworm | changed 2025-09-28 12:08:01.609868 | 2025-09-28 12:08:01.609992 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 12:08:01.865086 | debian-bookworm | ok 2025-09-28 12:08:01.872700 | 2025-09-28 12:08:01.872826 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 12:08:02.540108 | debian-bookworm | changed 2025-09-28 12:08:02.552031 | 2025-09-28 12:08:02.552199 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 12:08:03.183026 | debian-bookworm | changed 2025-09-28 12:08:03.189033 | 2025-09-28 12:08:03.189144 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 12:08:03.214705 | debian-bookworm | skipping: Conditional result was False 2025-09-28 12:08:03.220974 | 2025-09-28 12:08:03.221081 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 12:08:03.700428 | debian-bookworm -> localhost | changed 2025-09-28 12:08:03.722041 | 2025-09-28 12:08:03.722188 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 12:08:04.080607 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/30d994bdf02145c89c4e0387931abc58/work/30d994bdf02145c89c4e0387931abc58_id_rsa (zuul-build-sshkey) 2025-09-28 12:08:04.080865 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018516 2025-09-28 12:08:04.093021 | 2025-09-28 12:08:04.093167 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 12:08:04.525205 | debian-bookworm | ok 2025-09-28 12:08:04.532067 | 2025-09-28 12:08:04.532181 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 12:08:04.555999 | debian-bookworm | skipping: Conditional result was False 2025-09-28 12:08:04.567940 | 2025-09-28 12:08:04.568049 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 12:08:04.991404 | debian-bookworm | ok 2025-09-28 12:08:05.004050 | 2025-09-28 12:08:05.004163 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 12:08:05.043725 | debian-bookworm | ok 2025-09-28 12:08:05.049062 | 2025-09-28 12:08:05.049167 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 12:08:05.376591 | debian-bookworm -> localhost | ok 2025-09-28 12:08:05.383501 | 2025-09-28 12:08:05.383606 | TASK [validate-host : Collect information about the host] 2025-09-28 12:08:06.559416 | debian-bookworm | ok 2025-09-28 12:08:06.570877 | 2025-09-28 12:08:06.570991 | TASK [validate-host : Sanitize hostname] 2025-09-28 12:08:06.680898 | debian-bookworm | ok 2025-09-28 12:08:06.726559 | 2025-09-28 12:08:06.726679 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 12:08:07.276712 | debian-bookworm -> localhost | changed 2025-09-28 12:08:07.283858 | 2025-09-28 12:08:07.283972 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 12:08:07.692341 | debian-bookworm | ok 2025-09-28 12:08:07.700639 | 2025-09-28 12:08:07.700777 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 12:08:08.237364 | debian-bookworm -> localhost | changed 2025-09-28 12:08:08.247755 | 2025-09-28 12:08:08.247881 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 12:08:08.533641 | debian-bookworm | ok 2025-09-28 12:08:08.541545 | 2025-09-28 12:08:08.541682 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 12:08:09.448795 | debian-bookworm | changed: 2025-09-28 12:08:09.449058 | debian-bookworm | cd+++++++++ src/ 2025-09-28 12:08:09.449234 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 12:08:09.449281 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 12:08:09.449314 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-28 12:08:09.449345 | debian-bookworm | Containerfile 2025-09-28 12:08:09.449598 | debian-bookworm | 2025-09-28 12:14:50.500130 | debian-bookworm | ERROR 2025-09-28 12:14:50.500547 | debian-bookworm | { 2025-09-28 12:14:50.500639 | debian-bookworm | "delta": "0:00:18.138508", 2025-09-28 12:14:50.500696 | debian-bookworm | "end": "2025-09-28 12:14:50.364084", 2025-09-28 12:14:50.500754 | debian-bookworm | "msg": "non-zero return code", 2025-09-28 12:14:50.500799 | debian-bookworm | "rc": 1, 2025-09-28 12:14:50.500867 | debian-bookworm | "start": "2025-09-28 12:14:32.225576" 2025-09-28 12:14:50.500911 | debian-bookworm | } failure 2025-09-28 12:14:50.503940 | 2025-09-28 12:14:50.504059 | PLAY RECAP 2025-09-28 12:14:50.504163 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-28 12:14:50.504217 | 2025-09-28 12:14:50.652239 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-28 12:14:50.655671 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 12:14:51.379092 | 2025-09-28 12:14:51.379242 | PLAY [Base post] 2025-09-28 12:14:51.393054 | 2025-09-28 12:14:51.393177 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-28 12:14:52.209170 | debian-bookworm | changed 2025-09-28 12:14:52.218262 | 2025-09-28 12:14:52.218394 | PLAY RECAP 2025-09-28 12:14:52.218474 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-28 12:14:52.218549 | 2025-09-28 12:14:52.332290 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 12:14:52.334810 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-28 12:14:53.097715 | 2025-09-28 12:14:53.097870 | PLAY [Base post-logs] 2025-09-28 12:14:53.108537 | 2025-09-28 12:14:53.108666 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-28 12:14:53.549752 | localhost | changed 2025-09-28 12:14:53.560253 | 2025-09-28 12:14:53.560414 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-28 12:14:53.596790 | localhost | ok 2025-09-28 12:14:53.602087 | 2025-09-28 12:14:53.602216 | TASK [Set zuul-log-path fact] 2025-09-28 12:14:53.617962 | localhost | ok 2025-09-28 12:14:53.628174 | 2025-09-28 12:14:53.628288 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 12:14:53.655287 | localhost | ok 2025-09-28 12:14:53.661813 | 2025-09-28 12:14:53.661962 | TASK [upload-logs : Create log directories] 2025-09-28 12:14:54.161438 | localhost | changed 2025-09-28 12:14:54.166870 | 2025-09-28 12:14:54.167032 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-28 12:14:54.668410 | localhost -> localhost | ok: Runtime: 0:00:00.005219 2025-09-28 12:14:54.673256 | 2025-09-28 12:14:54.673398 | TASK [upload-logs : Upload logs to log server] 2025-09-28 12:14:55.238047 | localhost | Output suppressed because no_log was given 2025-09-28 12:14:55.241195 | 2025-09-28 12:14:55.241387 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 12:14:55.297522 | localhost | skipping: Conditional result was False 2025-09-28 12:14:55.302678 | localhost | skipping: Conditional result was False 2025-09-28 12:14:55.315425 | 2025-09-28 12:14:55.315662 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 12:14:55.362020 | localhost | skipping: Conditional result was False 2025-09-28 12:14:55.362668 | 2025-09-28 12:14:55.366350 | localhost | skipping: Conditional result was False 2025-09-28 12:14:55.379976 | 2025-09-28 12:14:55.380216 | LOOP [upload-logs : Upload console log and json output]