2025-09-27 00:00:08.672172 | Job console starting 2025-09-27 00:00:08.713251 | Updating git repos 2025-09-27 00:00:09.443289 | Cloning repos into workspace 2025-09-27 00:00:09.498815 | Restoring repo states 2025-09-27 00:00:09.513898 | Merging changes 2025-09-27 00:00:09.513923 | Checking out repos 2025-09-27 00:00:09.592417 | Preparing playbooks 2025-09-27 00:00:10.173372 | Running Ansible setup 2025-09-27 00:00:14.248697 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-27 00:00:15.665895 | 2025-09-27 00:00:15.666023 | PLAY [Base pre] 2025-09-27 00:00:15.730718 | 2025-09-27 00:00:15.730915 | TASK [Setup log path fact] 2025-09-27 00:00:15.772711 | debian-bookworm | ok 2025-09-27 00:00:15.818161 | 2025-09-27 00:00:15.818687 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-27 00:00:15.883231 | debian-bookworm | ok 2025-09-27 00:00:15.906627 | 2025-09-27 00:00:15.906739 | TASK [emit-job-header : Print job information] 2025-09-27 00:00:15.958918 | # Job Information 2025-09-27 00:00:15.959082 | Ansible Version: 2.16.14 2025-09-27 00:00:15.959167 | Job: container-image-kolla-ansible-push-2024.2 2025-09-27 00:00:15.959204 | Pipeline: periodic-midnight 2025-09-27 00:00:15.959227 | Executor: 521e9411259a 2025-09-27 00:00:15.959247 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-27 00:00:15.959271 | Event ID: 82aceea5fed74a03ab22379253a1a510 2025-09-27 00:00:15.965112 | 2025-09-27 00:00:15.966028 | LOOP [emit-job-header : Print node information] 2025-09-27 00:00:16.207374 | debian-bookworm | ok: 2025-09-27 00:00:16.207647 | debian-bookworm | # Node Information 2025-09-27 00:00:16.207688 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-27 00:00:16.207713 | debian-bookworm | Hostname: debian 2025-09-27 00:00:16.207734 | debian-bookworm | Username: zuul 2025-09-27 00:00:16.207755 | debian-bookworm | Distro: Debian 12.12 2025-09-27 00:00:16.207788 | debian-bookworm | Provider: regiocloud-a 2025-09-27 00:00:16.207810 | debian-bookworm | Region: 2025-09-27 00:00:16.207830 | debian-bookworm | Label: debian-bookworm 2025-09-27 00:00:16.207851 | debian-bookworm | Product Name: OpenStack Nova 2025-09-27 00:00:16.207870 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe9c:b2d5 2025-09-27 00:00:16.230944 | 2025-09-27 00:00:16.231155 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-27 00:00:17.209675 | debian-bookworm -> localhost | changed 2025-09-27 00:00:17.219982 | 2025-09-27 00:00:17.220133 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-27 00:00:19.468563 | debian-bookworm -> localhost | changed 2025-09-27 00:00:19.483661 | 2025-09-27 00:00:19.483758 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-27 00:00:20.043185 | debian-bookworm -> localhost | ok 2025-09-27 00:00:20.048963 | 2025-09-27 00:00:20.049055 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-27 00:00:20.091793 | debian-bookworm | ok 2025-09-27 00:00:20.141732 | debian-bookworm | included: /var/lib/zuul/builds/1ee65d8403604bd7a67f1a1ec47f4da6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-27 00:00:20.159629 | 2025-09-27 00:00:20.160103 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-27 00:00:21.736370 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-27 00:00:21.736579 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1ee65d8403604bd7a67f1a1ec47f4da6/work/1ee65d8403604bd7a67f1a1ec47f4da6_id_rsa 2025-09-27 00:00:21.736656 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1ee65d8403604bd7a67f1a1ec47f4da6/work/1ee65d8403604bd7a67f1a1ec47f4da6_id_rsa.pub 2025-09-27 00:00:21.736725 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-27 00:00:21.736747 | debian-bookworm -> localhost | SHA256:j5k49nlTJdg6+j9PUcnaYdXggy1ULQH4ji60TMw8YPo zuul-build-sshkey 2025-09-27 00:00:21.736776 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-27 00:00:21.736805 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-27 00:00:21.736824 | debian-bookworm -> localhost | | .oo++o| 2025-09-27 00:00:21.736843 | debian-bookworm -> localhost | | .. +o =| 2025-09-27 00:00:21.736860 | debian-bookworm -> localhost | | +o +*.| 2025-09-27 00:00:21.736877 | debian-bookworm -> localhost | | o . +.=o.| 2025-09-27 00:00:21.736965 | debian-bookworm -> localhost | | o =S + +.. | 2025-09-27 00:00:21.736994 | debian-bookworm -> localhost | | . .B=+ o . | 2025-09-27 00:00:21.737012 | debian-bookworm -> localhost | | .+++=.o . | 2025-09-27 00:00:21.737029 | debian-bookworm -> localhost | | .Eo=.+ .. | 2025-09-27 00:00:21.737047 | debian-bookworm -> localhost | | o+.o.o. | 2025-09-27 00:00:21.737064 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-27 00:00:21.737107 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.750793 2025-09-27 00:00:21.743102 | 2025-09-27 00:00:21.743179 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-27 00:00:21.803329 | debian-bookworm | ok 2025-09-27 00:00:21.819981 | debian-bookworm | included: /var/lib/zuul/builds/1ee65d8403604bd7a67f1a1ec47f4da6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-27 00:00:21.839357 | 2025-09-27 00:00:21.839454 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-27 00:00:21.877124 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:21.883769 | 2025-09-27 00:00:21.883891 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-27 00:00:22.631406 | debian-bookworm | changed 2025-09-27 00:00:22.642296 | 2025-09-27 00:00:22.643375 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-27 00:00:22.977865 | debian-bookworm | ok 2025-09-27 00:00:22.983078 | 2025-09-27 00:00:22.983170 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-27 00:00:23.785972 | debian-bookworm | changed 2025-09-27 00:00:23.797846 | 2025-09-27 00:00:23.797942 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-27 00:00:24.748359 | debian-bookworm | changed 2025-09-27 00:00:24.752905 | 2025-09-27 00:00:24.752979 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-27 00:00:24.797321 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:24.802304 | 2025-09-27 00:00:24.802390 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-27 00:00:25.982178 | debian-bookworm -> localhost | changed 2025-09-27 00:00:26.003968 | 2025-09-27 00:00:26.004081 | TASK [add-build-sshkey : Add back temp key] 2025-09-27 00:00:26.841683 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1ee65d8403604bd7a67f1a1ec47f4da6/work/1ee65d8403604bd7a67f1a1ec47f4da6_id_rsa (zuul-build-sshkey) 2025-09-27 00:00:26.841926 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022097 2025-09-27 00:00:26.849401 | 2025-09-27 00:00:26.849500 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-27 00:00:27.404741 | debian-bookworm | ok 2025-09-27 00:00:27.410088 | 2025-09-27 00:00:27.410191 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-27 00:00:27.444420 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:27.470158 | 2025-09-27 00:00:27.470267 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-27 00:00:28.007220 | debian-bookworm | ok 2025-09-27 00:00:28.032187 | 2025-09-27 00:00:28.032292 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-27 00:00:28.141339 | debian-bookworm | ok 2025-09-27 00:00:28.159699 | 2025-09-27 00:00:28.159861 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-27 00:00:29.067983 | debian-bookworm -> localhost | ok 2025-09-27 00:00:29.073304 | 2025-09-27 00:00:29.073404 | TASK [validate-host : Collect information about the host] 2025-09-27 00:00:30.704609 | debian-bookworm | ok 2025-09-27 00:00:30.712884 | 2025-09-27 00:00:30.726330 | TASK [validate-host : Sanitize hostname] 2025-09-27 00:00:30.975052 | debian-bookworm | ok 2025-09-27 00:00:31.065058 | 2025-09-27 00:00:31.065160 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-27 00:00:32.722371 | debian-bookworm -> localhost | changed 2025-09-27 00:00:32.727236 | 2025-09-27 00:00:32.727312 | TASK [validate-host : Collect information about zuul worker] 2025-09-27 00:00:33.371803 | debian-bookworm | ok 2025-09-27 00:00:33.375618 | 2025-09-27 00:00:33.375695 | TASK [validate-host : Write out all zuul information for each host] 2025-09-27 00:00:34.698327 | debian-bookworm -> localhost | changed 2025-09-27 00:00:34.706028 | 2025-09-27 00:00:34.706114 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-27 00:00:35.016553 | debian-bookworm | ok 2025-09-27 00:00:35.021149 | 2025-09-27 00:00:35.021224 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-27 00:00:36.647615 | debian-bookworm | changed: 2025-09-27 00:00:36.647769 | debian-bookworm | cd+++++++++ src/ 2025-09-27 00:00:36.647822 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-27 00:00:36.647844 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-27 00:00:36.647862 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-27 00:00:36.647879 | debian-bookworm | Containerfile 2025-09-27 00:00:36.647988 | debian-bookworm | 2025-09-27 00:10:10.033710 | debian-bookworm | ERROR 2025-09-27 00:10:10.034328 | debian-bookworm | { 2025-09-27 00:10:10.034446 | debian-bookworm | "delta": "0:00:21.823399", 2025-09-27 00:10:10.034518 | debian-bookworm | "end": "2025-09-27 00:10:09.587754", 2025-09-27 00:10:10.034589 | debian-bookworm | "msg": "non-zero return code", 2025-09-27 00:10:10.034649 | debian-bookworm | "rc": 1, 2025-09-27 00:10:10.034704 | debian-bookworm | "start": "2025-09-27 00:09:47.764355" 2025-09-27 00:10:10.034757 | debian-bookworm | } failure 2025-09-27 00:10:10.040815 | 2025-09-27 00:10:10.041005 | PLAY RECAP 2025-09-27 00:10:10.041130 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-27 00:10:10.041192 | 2025-09-27 00:10:10.178587 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-27 00:10:10.181263 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-27 00:10:10.945142 | 2025-09-27 00:10:10.945400 | PLAY [Base post] 2025-09-27 00:10:10.960150 | 2025-09-27 00:10:10.960302 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-27 00:10:11.819380 | debian-bookworm | changed 2025-09-27 00:10:11.828610 | 2025-09-27 00:10:11.828754 | PLAY RECAP 2025-09-27 00:10:11.828833 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-27 00:10:11.828971 | 2025-09-27 00:10:11.958993 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-27 00:10:11.960055 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-27 00:10:12.787481 | 2025-09-27 00:10:12.787647 | PLAY [Base post-logs] 2025-09-27 00:10:12.798666 | 2025-09-27 00:10:12.798793 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-27 00:10:13.271491 | localhost | changed 2025-09-27 00:10:13.281745 | 2025-09-27 00:10:13.281931 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-27 00:10:13.318046 | localhost | ok 2025-09-27 00:10:13.322005 | 2025-09-27 00:10:13.322120 | TASK [Set zuul-log-path fact] 2025-09-27 00:10:13.337569 | localhost | ok 2025-09-27 00:10:13.346614 | 2025-09-27 00:10:13.346722 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-27 00:10:13.383180 | localhost | ok 2025-09-27 00:10:13.389199 | 2025-09-27 00:10:13.389367 | TASK [upload-logs : Create log directories] 2025-09-27 00:10:13.884087 | localhost | changed 2025-09-27 00:10:13.890230 | 2025-09-27 00:10:13.891087 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-27 00:10:14.434626 | localhost -> localhost | ok: Runtime: 0:00:00.008204 2025-09-27 00:10:14.444972 | 2025-09-27 00:10:14.445169 | TASK [upload-logs : Upload logs to log server] 2025-09-27 00:10:15.010363 | localhost | Output suppressed because no_log was given 2025-09-27 00:10:15.012513 | 2025-09-27 00:10:15.012628 | LOOP [upload-logs : Compress console log and json output] 2025-09-27 00:10:15.078580 | localhost | skipping: Conditional result was False 2025-09-27 00:10:15.083660 | localhost | skipping: Conditional result was False 2025-09-27 00:10:15.094046 | 2025-09-27 00:10:15.094202 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-27 00:10:15.141397 | localhost | skipping: Conditional result was False 2025-09-27 00:10:15.141786 | 2025-09-27 00:10:15.146201 | localhost | skipping: Conditional result was False 2025-09-27 00:10:15.152440 | 2025-09-27 00:10:15.152603 | LOOP [upload-logs : Upload console log and json output]