2025-09-28 18:29:08.397883 | Job console starting 2025-09-28 18:29:08.414648 | Updating git repos 2025-09-28 18:29:08.464125 | Cloning repos into workspace 2025-09-28 18:29:08.523932 | Restoring repo states 2025-09-28 18:29:08.550717 | Merging changes 2025-09-28 18:29:08.550735 | Checking out repos 2025-09-28 18:29:08.608161 | Preparing playbooks 2025-09-28 18:29:09.290182 | Running Ansible setup 2025-09-28 18:29:13.366063 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 18:29:14.097539 | 2025-09-28 18:29:14.097703 | PLAY [Base pre] 2025-09-28 18:29:14.114883 | 2025-09-28 18:29:14.115033 | TASK [Setup log path fact] 2025-09-28 18:29:14.145283 | debian-bookworm | ok 2025-09-28 18:29:14.160771 | 2025-09-28 18:29:14.160892 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 18:29:14.202118 | debian-bookworm | ok 2025-09-28 18:29:14.212527 | 2025-09-28 18:29:14.212629 | TASK [emit-job-header : Print job information] 2025-09-28 18:29:14.269167 | # Job Information 2025-09-28 18:29:14.269436 | Ansible Version: 2.16.14 2025-09-28 18:29:14.269563 | Job: container-image-kolla-ansible-push-2024.2 2025-09-28 18:29:14.269635 | Pipeline: post 2025-09-28 18:29:14.269676 | Executor: 521e9411259a 2025-09-28 18:29:14.269711 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/2cc75b078cd6fb37c7f5ebeaf9e295898cb07115 2025-09-28 18:29:14.269750 | Event ID: 02189aa0-9c99-11f0-82eb-d5d1a365dbee 2025-09-28 18:29:14.277580 | 2025-09-28 18:29:14.277713 | LOOP [emit-job-header : Print node information] 2025-09-28 18:29:14.395319 | debian-bookworm | ok: 2025-09-28 18:29:14.395607 | debian-bookworm | # Node Information 2025-09-28 18:29:14.395679 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 18:29:14.395734 | debian-bookworm | Hostname: debian 2025-09-28 18:29:14.395783 | debian-bookworm | Username: zuul 2025-09-28 18:29:14.395830 | debian-bookworm | Distro: Debian 12.12 2025-09-28 18:29:14.395882 | debian-bookworm | Provider: regiocloud-a 2025-09-28 18:29:14.395929 | debian-bookworm | Region: 2025-09-28 18:29:14.395976 | debian-bookworm | Label: debian-bookworm 2025-09-28 18:29:14.396021 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 18:29:14.396066 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3b:dcab 2025-09-28 18:29:14.418720 | 2025-09-28 18:29:14.418919 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 18:29:14.907259 | debian-bookworm -> localhost | changed 2025-09-28 18:29:14.915586 | 2025-09-28 18:29:14.915800 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 18:29:16.065264 | debian-bookworm -> localhost | changed 2025-09-28 18:29:16.094991 | 2025-09-28 18:29:16.095144 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 18:29:16.425369 | debian-bookworm -> localhost | ok 2025-09-28 18:29:16.435009 | 2025-09-28 18:29:16.435171 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 18:29:16.469199 | debian-bookworm | ok 2025-09-28 18:29:16.489804 | debian-bookworm | included: /var/lib/zuul/builds/c516fd1c5bf640f1973e120119ea5842/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 18:29:16.496015 | 2025-09-28 18:29:16.496126 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 18:29:17.645758 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 18:29:17.645982 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c516fd1c5bf640f1973e120119ea5842/work/c516fd1c5bf640f1973e120119ea5842_id_rsa 2025-09-28 18:29:17.646023 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c516fd1c5bf640f1973e120119ea5842/work/c516fd1c5bf640f1973e120119ea5842_id_rsa.pub 2025-09-28 18:29:17.646051 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 18:29:17.646076 | debian-bookworm -> localhost | SHA256:C93qzaPuBe5lIvrQO8XIdedrUH2YuzR5n4tSSk+/3lg zuul-build-sshkey 2025-09-28 18:29:17.646111 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 18:29:17.646134 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 18:29:17.646155 | debian-bookworm -> localhost | | | 2025-09-28 18:29:17.646177 | debian-bookworm -> localhost | | | 2025-09-28 18:29:17.646198 | debian-bookworm -> localhost | | . o | 2025-09-28 18:29:17.646218 | debian-bookworm -> localhost | | .... o + .| 2025-09-28 18:29:17.646238 | debian-bookworm -> localhost | | ..+S..+ + | 2025-09-28 18:29:17.646263 | debian-bookworm -> localhost | | .ooo+...o= .| 2025-09-28 18:29:17.646284 | debian-bookworm -> localhost | | . o.= =.=o.+E| 2025-09-28 18:29:17.646304 | debian-bookworm -> localhost | | o.= B.oo.o=o| 2025-09-28 18:29:17.646325 | debian-bookworm -> localhost | | ..o+*.oo..o++| 2025-09-28 18:29:17.646345 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 18:29:17.646397 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.658668 2025-09-28 18:29:17.653123 | 2025-09-28 18:29:17.653256 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 18:29:17.681909 | debian-bookworm | ok 2025-09-28 18:29:17.691216 | debian-bookworm | included: /var/lib/zuul/builds/c516fd1c5bf640f1973e120119ea5842/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 18:29:17.700345 | 2025-09-28 18:29:17.700448 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 18:29:17.724351 | debian-bookworm | skipping: Conditional result was False 2025-09-28 18:29:17.730248 | 2025-09-28 18:29:17.730351 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 18:29:18.351042 | debian-bookworm | changed 2025-09-28 18:29:18.358293 | 2025-09-28 18:29:18.358430 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 18:29:18.613770 | debian-bookworm | ok 2025-09-28 18:29:18.621067 | 2025-09-28 18:29:18.621182 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 18:29:19.249797 | debian-bookworm | changed 2025-09-28 18:29:19.259143 | 2025-09-28 18:29:19.259256 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 18:29:19.894367 | debian-bookworm | changed 2025-09-28 18:29:19.904576 | 2025-09-28 18:29:19.904699 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 18:29:19.928495 | debian-bookworm | skipping: Conditional result was False 2025-09-28 18:29:19.937859 | 2025-09-28 18:29:19.937993 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 18:29:20.419539 | debian-bookworm -> localhost | changed 2025-09-28 18:29:20.430691 | 2025-09-28 18:29:20.430809 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 18:29:20.779436 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c516fd1c5bf640f1973e120119ea5842/work/c516fd1c5bf640f1973e120119ea5842_id_rsa (zuul-build-sshkey) 2025-09-28 18:29:20.780048 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019062 2025-09-28 18:29:20.798806 | 2025-09-28 18:29:20.798995 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 18:29:21.215019 | debian-bookworm | ok 2025-09-28 18:29:21.223778 | 2025-09-28 18:29:21.223905 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 18:29:21.247821 | debian-bookworm | skipping: Conditional result was False 2025-09-28 18:29:21.264099 | 2025-09-28 18:29:21.264206 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 18:29:21.689498 | debian-bookworm | ok 2025-09-28 18:29:21.703266 | 2025-09-28 18:29:21.703390 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 18:29:21.742605 | debian-bookworm | ok 2025-09-28 18:29:21.747757 | 2025-09-28 18:29:21.747863 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 18:29:22.034675 | debian-bookworm -> localhost | ok 2025-09-28 18:29:22.042624 | 2025-09-28 18:29:22.042745 | TASK [validate-host : Collect information about the host] 2025-09-28 18:29:23.166781 | debian-bookworm | ok 2025-09-28 18:29:23.181757 | 2025-09-28 18:29:23.181889 | TASK [validate-host : Sanitize hostname] 2025-09-28 18:29:23.288714 | debian-bookworm | ok 2025-09-28 18:29:23.332060 | 2025-09-28 18:29:23.332188 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 18:29:23.867874 | debian-bookworm -> localhost | changed 2025-09-28 18:29:23.873713 | 2025-09-28 18:29:23.873819 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 18:29:24.304580 | debian-bookworm | ok 2025-09-28 18:29:24.312220 | 2025-09-28 18:29:24.312356 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 18:29:24.873932 | debian-bookworm -> localhost | changed 2025-09-28 18:29:24.889690 | 2025-09-28 18:29:24.889820 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 18:29:25.217436 | debian-bookworm | ok 2025-09-28 18:29:25.226545 | 2025-09-28 18:29:25.226699 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 18:29:26.113285 | debian-bookworm | changed: 2025-09-28 18:29:26.113516 | debian-bookworm | cd+++++++++ src/ 2025-09-28 18:29:26.113552 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 18:29:26.113576 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 18:29:26.113598 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-28 18:29:26.113619 | debian-bookworm | Containerfile 2025-09-28 18:29:26.113750 | debian-bookworm | 2025-09-28 18:34:32.913435 | debian-bookworm | ERROR 2025-09-28 18:34:32.913902 | debian-bookworm | { 2025-09-28 18:34:32.914017 | debian-bookworm | "delta": "0:00:23.332575", 2025-09-28 18:34:32.914091 | debian-bookworm | "end": "2025-09-28 18:34:32.486810", 2025-09-28 18:34:32.914205 | debian-bookworm | "msg": "non-zero return code", 2025-09-28 18:34:32.914274 | debian-bookworm | "rc": 1, 2025-09-28 18:34:32.914333 | debian-bookworm | "start": "2025-09-28 18:34:09.154235" 2025-09-28 18:34:32.914387 | debian-bookworm | } failure 2025-09-28 18:34:32.917917 | 2025-09-28 18:34:32.918048 | PLAY RECAP 2025-09-28 18:34:32.918147 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-28 18:34:32.918218 | 2025-09-28 18:34:33.117944 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-28 18:34:33.121455 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 18:34:33.830431 | 2025-09-28 18:34:33.830585 | PLAY [Base post] 2025-09-28 18:34:33.844197 | 2025-09-28 18:34:33.844334 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-28 18:34:34.685178 | debian-bookworm | changed 2025-09-28 18:34:34.695218 | 2025-09-28 18:34:34.695354 | PLAY RECAP 2025-09-28 18:34:34.695436 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-28 18:34:34.695518 | 2025-09-28 18:34:34.815015 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 18:34:34.817639 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-28 18:34:35.588952 | 2025-09-28 18:34:35.589113 | PLAY [Base post-logs] 2025-09-28 18:34:35.599721 | 2025-09-28 18:34:35.599844 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-28 18:34:36.057102 | localhost | changed 2025-09-28 18:34:36.074673 | 2025-09-28 18:34:36.074881 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-28 18:34:36.113341 | localhost | ok 2025-09-28 18:34:36.121274 | 2025-09-28 18:34:36.121453 | TASK [Set zuul-log-path fact] 2025-09-28 18:34:36.149144 | localhost | ok 2025-09-28 18:34:36.161233 | 2025-09-28 18:34:36.161360 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 18:34:36.197704 | localhost | ok 2025-09-28 18:34:36.202674 | 2025-09-28 18:34:36.202814 | TASK [upload-logs : Create log directories] 2025-09-28 18:34:36.699623 | localhost | changed 2025-09-28 18:34:36.704309 | 2025-09-28 18:34:36.704463 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-28 18:34:37.196338 | localhost -> localhost | ok: Runtime: 0:00:00.006901 2025-09-28 18:34:37.204297 | 2025-09-28 18:34:37.204455 | TASK [upload-logs : Upload logs to log server] 2025-09-28 18:34:37.780290 | localhost | Output suppressed because no_log was given 2025-09-28 18:34:37.784219 | 2025-09-28 18:34:37.784431 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 18:34:37.838914 | localhost | skipping: Conditional result was False 2025-09-28 18:34:37.843861 | localhost | skipping: Conditional result was False 2025-09-28 18:34:37.856252 | 2025-09-28 18:34:37.856465 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 18:34:37.924014 | localhost | skipping: Conditional result was False 2025-09-28 18:34:37.924620 | 2025-09-28 18:34:37.934966 | localhost | skipping: Conditional result was False 2025-09-28 18:34:37.938762 | 2025-09-28 18:34:37.938933 | LOOP [upload-logs : Upload console log and json output]