2025-11-30 17:55:00.802990 | Job console starting 2025-11-30 17:55:00.815631 | Updating git repos 2025-11-30 17:55:00.836631 | Cloning repos into workspace 2025-11-30 17:55:00.894102 | Restoring repo states 2025-11-30 17:55:00.906922 | Merging changes 2025-11-30 17:55:00.906942 | Checking out repos 2025-11-30 17:55:00.988092 | Preparing playbooks 2025-11-30 17:55:01.697613 | Running Ansible setup 2025-11-30 17:55:05.907235 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-30 17:55:06.688481 | 2025-11-30 17:55:06.688672 | PLAY [Base pre] 2025-11-30 17:55:06.706661 | 2025-11-30 17:55:06.706821 | TASK [Setup log path fact] 2025-11-30 17:55:06.736473 | debian-bookworm | ok 2025-11-30 17:55:06.754325 | 2025-11-30 17:55:06.754512 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 17:55:06.823078 | debian-bookworm | ok 2025-11-30 17:55:06.842418 | 2025-11-30 17:55:06.842586 | TASK [emit-job-header : Print job information] 2025-11-30 17:55:06.899220 | # Job Information 2025-11-30 17:55:06.899560 | Ansible Version: 2.16.14 2025-11-30 17:55:06.899633 | Job: container-image-inventory-reconciler-push 2025-11-30 17:55:06.899739 | Pipeline: tag 2025-11-30 17:55:06.899808 | Executor: 521e9411259a 2025-11-30 17:55:06.899868 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/releases/tag/v0.20251130.0 2025-11-30 17:55:06.899932 | Event ID: ae93612c-ce15-11f0-9616-927450db325c 2025-11-30 17:55:06.909347 | 2025-11-30 17:55:06.909500 | LOOP [emit-job-header : Print node information] 2025-11-30 17:55:07.031339 | debian-bookworm | ok: 2025-11-30 17:55:07.031688 | debian-bookworm | # Node Information 2025-11-30 17:55:07.031761 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-30 17:55:07.031808 | debian-bookworm | Hostname: debian 2025-11-30 17:55:07.031856 | debian-bookworm | Username: zuul 2025-11-30 17:55:07.031897 | debian-bookworm | Distro: Debian 12.12 2025-11-30 17:55:07.031951 | debian-bookworm | Provider: regiocloud-a 2025-11-30 17:55:07.032041 | debian-bookworm | Region: 2025-11-30 17:55:07.032086 | debian-bookworm | Label: debian-bookworm 2025-11-30 17:55:07.032131 | debian-bookworm | Product Name: OpenStack Nova 2025-11-30 17:55:07.032176 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe8d:b1c2 2025-11-30 17:55:07.061017 | 2025-11-30 17:55:07.061258 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-30 17:55:07.565059 | debian-bookworm -> localhost | changed 2025-11-30 17:55:07.572898 | 2025-11-30 17:55:07.573054 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-30 17:55:08.635553 | debian-bookworm -> localhost | changed 2025-11-30 17:55:08.664563 | 2025-11-30 17:55:08.664830 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-30 17:55:08.968004 | debian-bookworm -> localhost | ok 2025-11-30 17:55:08.981233 | 2025-11-30 17:55:08.981403 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-30 17:55:09.019705 | debian-bookworm | ok 2025-11-30 17:55:09.043426 | debian-bookworm | included: /var/lib/zuul/builds/16973a851f5c42bc82bbd134b65f3552/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-30 17:55:09.049708 | 2025-11-30 17:55:09.049835 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-30 17:55:10.489646 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-30 17:55:10.490292 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/16973a851f5c42bc82bbd134b65f3552/work/16973a851f5c42bc82bbd134b65f3552_id_rsa 2025-11-30 17:55:10.490411 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/16973a851f5c42bc82bbd134b65f3552/work/16973a851f5c42bc82bbd134b65f3552_id_rsa.pub 2025-11-30 17:55:10.490485 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-30 17:55:10.490551 | debian-bookworm -> localhost | SHA256:YVmKjnYJ+m5FoXasjpBiSax5tBizBv2kxNAiSGG1VcA zuul-build-sshkey 2025-11-30 17:55:10.490634 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-30 17:55:10.490698 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-30 17:55:10.490759 | debian-bookworm -> localhost | |o=o..oo. . | 2025-11-30 17:55:10.490820 | debian-bookworm -> localhost | |* . oE.. + | 2025-11-30 17:55:10.490936 | debian-bookworm -> localhost | |o= ..o..= | 2025-11-30 17:55:10.490995 | debian-bookworm -> localhost | |+o=.+++o . | 2025-11-30 17:55:10.491088 | debian-bookworm -> localhost | |+Xo*o++ S | 2025-11-30 17:55:10.491154 | debian-bookworm -> localhost | |O++oo.. | 2025-11-30 17:55:10.491217 | debian-bookworm -> localhost | |+o o.. | 2025-11-30 17:55:10.491275 | debian-bookworm -> localhost | | ..o | 2025-11-30 17:55:10.491334 | debian-bookworm -> localhost | | .. | 2025-11-30 17:55:10.491390 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-30 17:55:10.491526 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.927566 2025-11-30 17:55:10.505610 | 2025-11-30 17:55:10.505772 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-30 17:55:10.537620 | debian-bookworm | ok 2025-11-30 17:55:10.547327 | debian-bookworm | included: /var/lib/zuul/builds/16973a851f5c42bc82bbd134b65f3552/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-30 17:55:10.556506 | 2025-11-30 17:55:10.556614 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-30 17:55:10.580401 | debian-bookworm | skipping: Conditional result was False 2025-11-30 17:55:10.587083 | 2025-11-30 17:55:10.587199 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-30 17:55:11.264407 | debian-bookworm | changed 2025-11-30 17:55:11.273786 | 2025-11-30 17:55:11.273967 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-30 17:55:11.556395 | debian-bookworm | ok 2025-11-30 17:55:11.565529 | 2025-11-30 17:55:11.565686 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-30 17:55:12.232685 | debian-bookworm | changed 2025-11-30 17:55:12.242248 | 2025-11-30 17:55:12.242403 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-30 17:55:12.883196 | debian-bookworm | changed 2025-11-30 17:55:12.892550 | 2025-11-30 17:55:12.892707 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-30 17:55:12.927474 | debian-bookworm | skipping: Conditional result was False 2025-11-30 17:55:12.936866 | 2025-11-30 17:55:12.937008 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-30 17:55:13.418908 | debian-bookworm -> localhost | changed 2025-11-30 17:55:13.440478 | 2025-11-30 17:55:13.440625 | TASK [add-build-sshkey : Add back temp key] 2025-11-30 17:55:13.831073 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/16973a851f5c42bc82bbd134b65f3552/work/16973a851f5c42bc82bbd134b65f3552_id_rsa (zuul-build-sshkey) 2025-11-30 17:55:13.831490 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.020206 2025-11-30 17:55:13.843332 | 2025-11-30 17:55:13.843499 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-30 17:55:14.257780 | debian-bookworm | ok 2025-11-30 17:55:14.265692 | 2025-11-30 17:55:14.265831 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-30 17:55:14.300714 | debian-bookworm | skipping: Conditional result was False 2025-11-30 17:55:14.313107 | 2025-11-30 17:55:14.313223 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-30 17:55:14.776978 | debian-bookworm | ok 2025-11-30 17:55:14.792898 | 2025-11-30 17:55:14.793026 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-30 17:55:14.839683 | debian-bookworm | ok 2025-11-30 17:55:14.847499 | 2025-11-30 17:55:14.847629 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-30 17:55:15.206483 | debian-bookworm -> localhost | ok 2025-11-30 17:55:15.213770 | 2025-11-30 17:55:15.213907 | TASK [validate-host : Collect information about the host] 2025-11-30 17:55:16.387712 | debian-bookworm | ok 2025-11-30 17:55:16.401646 | 2025-11-30 17:55:16.401782 | TASK [validate-host : Sanitize hostname] 2025-11-30 17:55:16.513200 | debian-bookworm | ok 2025-11-30 17:55:16.558821 | 2025-11-30 17:55:16.559014 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-30 17:55:17.172188 | debian-bookworm -> localhost | changed 2025-11-30 17:55:17.184749 | 2025-11-30 17:55:17.184940 | TASK [validate-host : Collect information about zuul worker] 2025-11-30 17:55:17.597278 | debian-bookworm | ok 2025-11-30 17:55:17.605085 | 2025-11-30 17:55:17.605230 | TASK [validate-host : Write out all zuul information for each host] 2025-11-30 17:55:18.172185 | debian-bookworm -> localhost | changed 2025-11-30 17:55:18.196939 | 2025-11-30 17:55:18.197279 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-30 17:55:18.489183 | debian-bookworm | ok 2025-11-30 17:55:18.500207 | 2025-11-30 17:55:18.500391 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-30 17:55:19.640583 | debian-bookworm | changed: 2025-11-30 17:55:19.640881 | debian-bookworm | cd+++++++++ src/ 2025-11-30 17:55:19.640938 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-30 17:55:19.640977 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-30 17:55:19.641013 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-11-30 17:55:19.641108 | debian-bookworm | Containerfile 2025-11-30 17:55:19.641327 | debian-bookworm | [builder 8/22] RUN <>> RUN <>> set -e 2025-11-30 17:56:28.818622 | debian-bookworm | 49 | >>> set -x 2025-11-30 17:56:28.818632 | debian-bookworm | 50 | >>> 2025-11-30 17:56:28.818642 | debian-bookworm | 51 | >>> git clone https://github.com/osism/release /release 2025-11-30 17:56:28.818652 | debian-bookworm | 52 | >>> git clone https://github.com/osism/defaults /defaults 2025-11-30 17:56:28.818662 | debian-bookworm | 53 | >>> git clone https://github.com/osism/cfg-generics /generics 2025-11-30 17:56:28.818672 | debian-bookworm | 54 | >>> 2025-11-30 17:56:28.818682 | debian-bookworm | 55 | >>> if [ "$VERSION" != "latest" ]; then 2025-11-30 17:56:28.818692 | debian-bookworm | 56 | >>> ( cd /release || exit; git fetch --all --force; git checkout "inventory-reconciler-$VERSION" ) 2025-11-30 17:56:28.818702 | debian-bookworm | 57 | >>> ( cd /defaults || exit; git fetch --all --force; git checkout "$(yq -M -r .defaults_version "/release/latest/base.yml")" ) 2025-11-30 17:56:28.818725 | debian-bookworm | 58 | >>> ( cd /generics || exit; git fetch --all --force; git checkout "$(yq -M -r .generics_version "/release/latest/base.yml")" ) 2025-11-30 17:56:28.818735 | debian-bookworm | 59 | >>> fi 2025-11-30 17:56:28.818745 | debian-bookworm | 60 | >>> EOF 2025-11-30 17:56:28.818755 | debian-bookworm | 61 | 2025-11-30 17:56:28.818766 | debian-bookworm | -------------------- 2025-11-30 17:56:28.818780 | debian-bookworm | ERROR: failed to build: failed to solve: process "/bin/sh -c set -e\nset -x\n\ngit clone https://github.com/osism/release /release\ngit clone https://github.com/osism/defaults /defaults\ngit clone https://github.com/osism/cfg-generics /generics\n\nif [ \"$VERSION\" != \"latest\" ]; then\n ( cd /release || exit; git fetch --all --force; git checkout \"inventory-reconciler-$VERSION\" )\n ( cd /defaults || exit; git fetch --all --force; git checkout \"$(yq -M -r .defaults_version \"/release/latest/base.yml\")\" )\n ( cd /generics || exit; git fetch --all --force; git checkout \"$(yq -M -r .generics_version \"/release/latest/base.yml\")\" )\nfi\n" did not complete successfully: exit code: 1 2025-11-30 17:56:29.051077 | debian-bookworm | ERROR 2025-11-30 17:56:29.051775 | debian-bookworm | { 2025-11-30 17:56:29.051886 | debian-bookworm | "delta": "0:00:18.345555", 2025-11-30 17:56:29.051956 | debian-bookworm | "end": "2025-11-30 17:56:28.826771", 2025-11-30 17:56:29.052018 | debian-bookworm | "msg": "non-zero return code", 2025-11-30 17:56:29.052074 | debian-bookworm | "rc": 1, 2025-11-30 17:56:29.052127 | debian-bookworm | "start": "2025-11-30 17:56:10.481216" 2025-11-30 17:56:29.052213 | debian-bookworm | } failure 2025-11-30 17:56:29.075671 | 2025-11-30 17:56:29.075808 | PLAY RECAP 2025-11-30 17:56:29.075893 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-11-30 17:56:29.075935 | 2025-11-30 17:56:29.254067 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-inventory-reconciler/playbooks/build.yml@main] 2025-11-30 17:56:29.255481 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-30 17:56:30.044420 | 2025-11-30 17:56:30.044584 | PLAY [Base post] 2025-11-30 17:56:30.059253 | 2025-11-30 17:56:30.059392 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-30 17:56:30.877092 | debian-bookworm | changed 2025-11-30 17:56:30.887986 | 2025-11-30 17:56:30.888130 | PLAY RECAP 2025-11-30 17:56:30.888421 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-30 17:56:30.888497 | 2025-11-30 17:56:31.051922 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-30 17:56:31.053103 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-30 17:56:31.938554 | 2025-11-30 17:56:31.938733 | PLAY [Base post-logs] 2025-11-30 17:56:31.950279 | 2025-11-30 17:56:31.950428 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-30 17:56:32.394470 | localhost | changed 2025-11-30 17:56:32.412705 | 2025-11-30 17:56:32.412882 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-30 17:56:32.453438 | localhost | ok 2025-11-30 17:56:32.461141 | 2025-11-30 17:56:32.461319 | TASK [Set zuul-log-path fact] 2025-11-30 17:56:32.479765 | localhost | ok 2025-11-30 17:56:32.492843 | 2025-11-30 17:56:32.492982 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 17:56:32.520410 | localhost | ok 2025-11-30 17:56:32.525391 | 2025-11-30 17:56:32.525558 | TASK [upload-logs : Create log directories] 2025-11-30 17:56:33.054393 | localhost | changed 2025-11-30 17:56:33.058992 | 2025-11-30 17:56:33.059166 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-30 17:56:33.613715 | localhost -> localhost | ok: Runtime: 0:00:00.006964 2025-11-30 17:56:33.623541 | 2025-11-30 17:56:33.623829 | TASK [upload-logs : Upload logs to log server] 2025-11-30 17:56:34.230312 | localhost | Output suppressed because no_log was given 2025-11-30 17:56:34.233598 | 2025-11-30 17:56:34.233776 | LOOP [upload-logs : Compress console log and json output] 2025-11-30 17:56:34.290805 | localhost | skipping: Conditional result was False 2025-11-30 17:56:34.299852 | localhost | skipping: Conditional result was False 2025-11-30 17:56:34.317292 | 2025-11-30 17:56:34.317537 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-30 17:56:34.385966 | localhost | skipping: Conditional result was False 2025-11-30 17:56:34.386448 | 2025-11-30 17:56:34.395324 | localhost | skipping: Conditional result was False 2025-11-30 17:56:34.401618 | 2025-11-30 17:56:34.401857 | LOOP [upload-logs : Upload console log and json output]