2025-09-15 00:00:07.409493 | Job console starting 2025-09-15 00:00:07.426286 | Updating git repos 2025-09-15 00:00:07.762131 | Cloning repos into workspace 2025-09-15 00:00:07.860463 | Restoring repo states 2025-09-15 00:00:07.873232 | Merging changes 2025-09-15 00:00:07.873243 | Checking out repos 2025-09-15 00:00:07.940686 | Preparing playbooks 2025-09-15 00:00:08.474963 | Running Ansible setup 2025-09-15 00:00:13.890748 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-15 00:00:15.027984 | 2025-09-15 00:00:15.028103 | PLAY [Base pre] 2025-09-15 00:00:15.045286 | 2025-09-15 00:00:15.045449 | TASK [Setup log path fact] 2025-09-15 00:00:15.114106 | debian-bookworm | ok 2025-09-15 00:00:15.131436 | 2025-09-15 00:00:15.131553 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-15 00:00:15.218253 | debian-bookworm | ok 2025-09-15 00:00:15.246420 | 2025-09-15 00:00:15.246560 | TASK [emit-job-header : Print job information] 2025-09-15 00:00:15.352060 | # Job Information 2025-09-15 00:00:15.352235 | Ansible Version: 2.16.14 2025-09-15 00:00:15.352267 | Job: container-image-kolla-ansible-push-2024.1 2025-09-15 00:00:15.352295 | Pipeline: periodic-midnight 2025-09-15 00:00:15.352314 | Executor: 521e9411259a 2025-09-15 00:00:15.352354 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-15 00:00:15.352374 | Event ID: e8fab4567fd04160b2bc0642eff6f2c5 2025-09-15 00:00:15.357272 | 2025-09-15 00:00:15.357404 | LOOP [emit-job-header : Print node information] 2025-09-15 00:00:15.548018 | debian-bookworm | ok: 2025-09-15 00:00:15.548198 | debian-bookworm | # Node Information 2025-09-15 00:00:15.548229 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-15 00:00:15.548252 | debian-bookworm | Hostname: debian 2025-09-15 00:00:15.548272 | debian-bookworm | Username: zuul 2025-09-15 00:00:15.548291 | debian-bookworm | Distro: Debian 12.12 2025-09-15 00:00:15.548312 | debian-bookworm | Provider: regiocloud-a 2025-09-15 00:00:15.548353 | debian-bookworm | Region: 2025-09-15 00:00:15.548373 | debian-bookworm | Label: debian-bookworm 2025-09-15 00:00:15.548391 | debian-bookworm | Product Name: OpenStack Nova 2025-09-15 00:00:15.548407 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec7:29ed 2025-09-15 00:00:15.571374 | 2025-09-15 00:00:15.571494 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-15 00:00:16.595565 | debian-bookworm -> localhost | changed 2025-09-15 00:00:16.604004 | 2025-09-15 00:00:16.604116 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-15 00:00:19.437753 | debian-bookworm -> localhost | changed 2025-09-15 00:00:19.468693 | 2025-09-15 00:00:19.471460 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-15 00:00:20.185037 | debian-bookworm -> localhost | ok 2025-09-15 00:00:20.191056 | 2025-09-15 00:00:20.191149 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-15 00:00:20.238166 | debian-bookworm | ok 2025-09-15 00:00:20.270498 | debian-bookworm | included: /var/lib/zuul/builds/9245d2eedfab462b980f1a0ba0daad9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-15 00:00:20.282274 | 2025-09-15 00:00:20.282389 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-15 00:00:23.748934 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-15 00:00:23.749100 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9245d2eedfab462b980f1a0ba0daad9f/work/9245d2eedfab462b980f1a0ba0daad9f_id_rsa 2025-09-15 00:00:23.749131 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9245d2eedfab462b980f1a0ba0daad9f/work/9245d2eedfab462b980f1a0ba0daad9f_id_rsa.pub 2025-09-15 00:00:23.749152 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-15 00:00:23.749172 | debian-bookworm -> localhost | SHA256:oMlEHNdmqRZ2M2HGIXTWUR/SbLqEtl94Cn8nati1lz8 zuul-build-sshkey 2025-09-15 00:00:23.749198 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-15 00:00:23.749217 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-15 00:00:23.749234 | debian-bookworm -> localhost | | .oo+oB=.ooo. | 2025-09-15 00:00:23.749252 | debian-bookworm -> localhost | | ...o*X . o+. | 2025-09-15 00:00:23.749269 | debian-bookworm -> localhost | | ...* o . o. | 2025-09-15 00:00:23.749285 | debian-bookworm -> localhost | | o oo. o o | 2025-09-15 00:00:23.749301 | debian-bookworm -> localhost | | +. S. o o | 2025-09-15 00:00:23.749333 | debian-bookworm -> localhost | | o o + | 2025-09-15 00:00:23.749352 | debian-bookworm -> localhost | | * = ..| 2025-09-15 00:00:23.749369 | debian-bookworm -> localhost | | . * +Eo| 2025-09-15 00:00:23.749386 | debian-bookworm -> localhost | | ..o ++| 2025-09-15 00:00:23.749403 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-15 00:00:23.749444 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.318670 2025-09-15 00:00:23.755394 | 2025-09-15 00:00:23.755488 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-15 00:00:23.793072 | debian-bookworm | ok 2025-09-15 00:00:23.807727 | debian-bookworm | included: /var/lib/zuul/builds/9245d2eedfab462b980f1a0ba0daad9f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-15 00:00:23.823645 | 2025-09-15 00:00:23.823740 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-15 00:00:23.857615 | debian-bookworm | skipping: Conditional result was False 2025-09-15 00:00:23.862968 | 2025-09-15 00:00:23.863054 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-15 00:00:24.809359 | debian-bookworm | changed 2025-09-15 00:00:24.813841 | 2025-09-15 00:00:24.813923 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-15 00:00:25.081650 | debian-bookworm | ok 2025-09-15 00:00:25.086235 | 2025-09-15 00:00:25.086317 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-15 00:00:25.791229 | debian-bookworm | changed 2025-09-15 00:00:25.796638 | 2025-09-15 00:00:25.796720 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-15 00:00:26.578890 | debian-bookworm | changed 2025-09-15 00:00:26.583312 | 2025-09-15 00:00:26.583410 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-15 00:00:26.631042 | debian-bookworm | skipping: Conditional result was False 2025-09-15 00:00:26.636135 | 2025-09-15 00:00:26.636227 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-15 00:00:27.687698 | debian-bookworm -> localhost | changed 2025-09-15 00:00:27.696451 | 2025-09-15 00:00:27.696548 | TASK [add-build-sshkey : Add back temp key] 2025-09-15 00:00:28.661148 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9245d2eedfab462b980f1a0ba0daad9f/work/9245d2eedfab462b980f1a0ba0daad9f_id_rsa (zuul-build-sshkey) 2025-09-15 00:00:28.661370 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.029205 2025-09-15 00:00:28.667961 | 2025-09-15 00:00:28.668049 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-15 00:00:29.221769 | debian-bookworm | ok 2025-09-15 00:00:29.225976 | 2025-09-15 00:00:29.226056 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-15 00:00:29.258920 | debian-bookworm | skipping: Conditional result was False 2025-09-15 00:00:29.268178 | 2025-09-15 00:00:29.268275 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-15 00:00:29.804394 | debian-bookworm | ok 2025-09-15 00:00:29.825997 | 2025-09-15 00:00:29.826093 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-15 00:00:29.872058 | debian-bookworm | ok 2025-09-15 00:00:29.876155 | 2025-09-15 00:00:29.876231 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-15 00:00:30.601905 | debian-bookworm -> localhost | ok 2025-09-15 00:00:30.607138 | 2025-09-15 00:00:30.607232 | TASK [validate-host : Collect information about the host] 2025-09-15 00:00:32.088399 | debian-bookworm | ok 2025-09-15 00:00:32.108915 | 2025-09-15 00:00:32.109073 | TASK [validate-host : Sanitize hostname] 2025-09-15 00:00:32.357450 | debian-bookworm | ok 2025-09-15 00:00:32.454150 | 2025-09-15 00:00:32.454255 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-15 00:00:33.403310 | debian-bookworm -> localhost | changed 2025-09-15 00:00:33.408138 | 2025-09-15 00:00:33.408219 | TASK [validate-host : Collect information about zuul worker] 2025-09-15 00:00:33.894777 | debian-bookworm | ok 2025-09-15 00:00:33.898586 | 2025-09-15 00:00:33.898658 | TASK [validate-host : Write out all zuul information for each host] 2025-09-15 00:00:34.988609 | debian-bookworm -> localhost | changed 2025-09-15 00:00:34.996466 | 2025-09-15 00:00:34.996555 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-15 00:00:35.244995 | debian-bookworm | ok 2025-09-15 00:00:35.249527 | 2025-09-15 00:00:35.249609 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-15 00:00:36.521614 | debian-bookworm | changed: 2025-09-15 00:00:36.521769 | debian-bookworm | cd+++++++++ src/ 2025-09-15 00:00:36.521797 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-15 00:00:36.521817 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-15 00:00:36.521834 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-15 00:00:36.521852 | debian-bookworm | Containerfile 2025-09-15 00:00:36.521961 | debian-bookworm | 2025-09-15 00:09:49.952448 | debian-bookworm | ERROR 2025-09-15 00:09:49.952764 | debian-bookworm | { 2025-09-15 00:09:49.952835 | debian-bookworm | "delta": "0:00:20.704396", 2025-09-15 00:09:49.952881 | debian-bookworm | "end": "2025-09-15 00:09:49.885900", 2025-09-15 00:09:49.952927 | debian-bookworm | "msg": "non-zero return code", 2025-09-15 00:09:49.952967 | debian-bookworm | "rc": 1, 2025-09-15 00:09:49.953028 | debian-bookworm | "start": "2025-09-15 00:09:29.181504" 2025-09-15 00:09:49.953085 | debian-bookworm | } failure 2025-09-15 00:09:49.956317 | 2025-09-15 00:09:49.956424 | PLAY RECAP 2025-09-15 00:09:49.956512 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-15 00:09:49.956555 | 2025-09-15 00:09:50.145512 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-15 00:09:50.148123 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-15 00:09:50.884088 | 2025-09-15 00:09:50.884286 | PLAY [Base post] 2025-09-15 00:09:50.898461 | 2025-09-15 00:09:50.898594 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-15 00:09:51.743947 | debian-bookworm | changed 2025-09-15 00:09:51.753369 | 2025-09-15 00:09:51.753501 | PLAY RECAP 2025-09-15 00:09:51.753584 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-15 00:09:51.753664 | 2025-09-15 00:09:51.885418 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-15 00:09:51.886507 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-15 00:09:52.674031 | 2025-09-15 00:09:52.674213 | PLAY [Base post-logs] 2025-09-15 00:09:52.685171 | 2025-09-15 00:09:52.685304 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-15 00:09:53.177280 | localhost | changed 2025-09-15 00:09:53.193771 | 2025-09-15 00:09:53.194040 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-15 00:09:53.220247 | localhost | ok 2025-09-15 00:09:53.224347 | 2025-09-15 00:09:53.224457 | TASK [Set zuul-log-path fact] 2025-09-15 00:09:53.240150 | localhost | ok 2025-09-15 00:09:53.251461 | 2025-09-15 00:09:53.251576 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-15 00:09:53.277240 | localhost | ok 2025-09-15 00:09:53.281296 | 2025-09-15 00:09:53.281423 | TASK [upload-logs : Create log directories] 2025-09-15 00:09:53.779507 | localhost | changed 2025-09-15 00:09:53.784150 | 2025-09-15 00:09:53.784390 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-15 00:09:54.315521 | localhost -> localhost | ok: Runtime: 0:00:00.006616 2025-09-15 00:09:54.320006 | 2025-09-15 00:09:54.320129 | TASK [upload-logs : Upload logs to log server] 2025-09-15 00:09:54.882393 | localhost | Output suppressed because no_log was given 2025-09-15 00:09:54.885327 | 2025-09-15 00:09:54.885496 | LOOP [upload-logs : Compress console log and json output] 2025-09-15 00:09:54.941403 | localhost | skipping: Conditional result was False 2025-09-15 00:09:54.946831 | localhost | skipping: Conditional result was False 2025-09-15 00:09:54.958550 | 2025-09-15 00:09:54.958828 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-15 00:09:55.014958 | localhost | skipping: Conditional result was False 2025-09-15 00:09:55.015604 | 2025-09-15 00:09:55.019051 | localhost | skipping: Conditional result was False 2025-09-15 00:09:55.032394 | 2025-09-15 00:09:55.032630 | LOOP [upload-logs : Upload console log and json output]