2025-11-24 13:55:12.860421 | Job console starting 2025-11-24 13:55:12.877882 | Updating git repos 2025-11-24 13:55:12.907633 | Cloning repos into workspace 2025-11-24 13:55:12.992178 | Restoring repo states 2025-11-24 13:55:13.022522 | Merging changes 2025-11-24 13:55:13.022553 | Checking out repos 2025-11-24 13:55:13.109352 | Preparing playbooks 2025-11-24 13:55:13.913988 | Running Ansible setup 2025-11-24 13:55:19.270419 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-11-24 13:55:20.054123 | 2025-11-24 13:55:20.055076 | PLAY [Base pre] 2025-11-24 13:55:20.072862 | 2025-11-24 13:55:20.073015 | TASK [Setup log path fact] 2025-11-24 13:55:20.109947 | debian-bookworm | ok 2025-11-24 13:55:20.133639 | 2025-11-24 13:55:20.133844 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-24 13:55:20.183151 | debian-bookworm | ok 2025-11-24 13:55:20.200687 | 2025-11-24 13:55:20.200857 | TASK [emit-job-header : Print job information] 2025-11-24 13:55:20.250368 | # Job Information 2025-11-24 13:55:20.250599 | Ansible Version: 2.16.14 2025-11-24 13:55:20.250638 | Job: container-image-inventory-reconciler-push 2025-11-24 13:55:20.250671 | Pipeline: tag 2025-11-24 13:55:20.250695 | Executor: 521e9411259a 2025-11-24 13:55:20.250717 | Triggered by: https://github.com/osism/container-image-inventory-reconciler/releases/tag/v0.20251124.0 2025-11-24 13:55:20.250740 | Event ID: 2f81c428-c93d-11f0-9c08-1c17c6f46a65 2025-11-24 13:55:20.255896 | 2025-11-24 13:55:20.256011 | LOOP [emit-job-header : Print node information] 2025-11-24 13:55:20.410823 | debian-bookworm | ok: 2025-11-24 13:55:20.411061 | debian-bookworm | # Node Information 2025-11-24 13:55:20.411100 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-11-24 13:55:20.411129 | debian-bookworm | Hostname: debian 2025-11-24 13:55:20.411155 | debian-bookworm | Username: zuul 2025-11-24 13:55:20.411178 | debian-bookworm | Distro: Debian 12.12 2025-11-24 13:55:20.411206 | debian-bookworm | Provider: regiocloud-a 2025-11-24 13:55:20.411228 | debian-bookworm | Region: 2025-11-24 13:55:20.411251 | debian-bookworm | Label: debian-bookworm 2025-11-24 13:55:20.411273 | debian-bookworm | Product Name: OpenStack Nova 2025-11-24 13:55:20.411294 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7e:3826 2025-11-24 13:55:20.423068 | 2025-11-24 13:55:20.423209 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-24 13:55:20.929448 | debian-bookworm -> localhost | changed 2025-11-24 13:55:20.947958 | 2025-11-24 13:55:20.948182 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-24 13:55:22.173705 | debian-bookworm -> localhost | changed 2025-11-24 13:55:22.196405 | 2025-11-24 13:55:22.196711 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-24 13:55:22.505166 | debian-bookworm -> localhost | ok 2025-11-24 13:55:22.511930 | 2025-11-24 13:55:22.512075 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-24 13:55:22.542784 | debian-bookworm | ok 2025-11-24 13:55:22.565377 | debian-bookworm | included: /var/lib/zuul/builds/564a1d818e794e269490e3681c47460f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-24 13:55:22.573750 | 2025-11-24 13:55:22.573872 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-24 13:55:23.528546 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-11-24 13:55:23.529199 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/564a1d818e794e269490e3681c47460f/work/564a1d818e794e269490e3681c47460f_id_rsa 2025-11-24 13:55:23.529323 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/564a1d818e794e269490e3681c47460f/work/564a1d818e794e269490e3681c47460f_id_rsa.pub 2025-11-24 13:55:23.529402 | debian-bookworm -> localhost | The key fingerprint is: 2025-11-24 13:55:23.529471 | debian-bookworm -> localhost | SHA256:hVu97m0MvUBa5j1fpkHicU5MrKkbKoTPdMprYvVh1mY zuul-build-sshkey 2025-11-24 13:55:23.529557 | debian-bookworm -> localhost | The key's randomart image is: 2025-11-24 13:55:23.529650 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-11-24 13:55:23.529711 | debian-bookworm -> localhost | | . | 2025-11-24 13:55:23.529772 | debian-bookworm -> localhost | | . . o | 2025-11-24 13:55:23.529829 | debian-bookworm -> localhost | | . o .= | 2025-11-24 13:55:23.529885 | debian-bookworm -> localhost | | + O.= | 2025-11-24 13:55:23.529942 | debian-bookworm -> localhost | | . S. O.X | 2025-11-24 13:55:23.530009 | debian-bookworm -> localhost | | . + = E.= * o| 2025-11-24 13:55:23.530065 | debian-bookworm -> localhost | | B * = o.+ B.| 2025-11-24 13:55:23.530121 | debian-bookworm -> localhost | | o B o .. .= .| 2025-11-24 13:55:23.530179 | debian-bookworm -> localhost | | . o.o ... | 2025-11-24 13:55:23.530237 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-11-24 13:55:23.530373 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.411750 2025-11-24 13:55:23.543759 | 2025-11-24 13:55:23.543914 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-24 13:55:23.589128 | debian-bookworm | ok 2025-11-24 13:55:23.602347 | debian-bookworm | included: /var/lib/zuul/builds/564a1d818e794e269490e3681c47460f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-24 13:55:23.611872 | 2025-11-24 13:55:23.611977 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-24 13:55:23.646469 | debian-bookworm | skipping: Conditional result was False 2025-11-24 13:55:23.657402 | 2025-11-24 13:55:23.657561 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-24 13:55:24.285751 | debian-bookworm | changed 2025-11-24 13:55:24.294630 | 2025-11-24 13:55:24.294780 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-24 13:55:24.554273 | debian-bookworm | ok 2025-11-24 13:55:24.562670 | 2025-11-24 13:55:24.562828 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-24 13:55:25.300653 | debian-bookworm | changed 2025-11-24 13:55:25.311418 | 2025-11-24 13:55:25.311588 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-24 13:55:25.979748 | debian-bookworm | changed 2025-11-24 13:55:25.988320 | 2025-11-24 13:55:25.988460 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-24 13:55:26.023448 | debian-bookworm | skipping: Conditional result was False 2025-11-24 13:55:26.041625 | 2025-11-24 13:55:26.041889 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-24 13:55:26.524795 | debian-bookworm -> localhost | changed 2025-11-24 13:55:26.548702 | 2025-11-24 13:55:26.548857 | TASK [add-build-sshkey : Add back temp key] 2025-11-24 13:55:26.911605 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/564a1d818e794e269490e3681c47460f/work/564a1d818e794e269490e3681c47460f_id_rsa (zuul-build-sshkey) 2025-11-24 13:55:26.912242 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019583 2025-11-24 13:55:26.930085 | 2025-11-24 13:55:26.930280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-24 13:55:27.346256 | debian-bookworm | ok 2025-11-24 13:55:27.353548 | 2025-11-24 13:55:27.353725 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-24 13:55:27.388793 | debian-bookworm | skipping: Conditional result was False 2025-11-24 13:55:27.407137 | 2025-11-24 13:55:27.407296 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-24 13:55:27.881344 | debian-bookworm | ok 2025-11-24 13:55:27.896807 | 2025-11-24 13:55:27.896960 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-24 13:55:27.950705 | debian-bookworm | ok 2025-11-24 13:55:27.958936 | 2025-11-24 13:55:27.959080 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-24 13:55:28.290701 | debian-bookworm -> localhost | ok 2025-11-24 13:55:28.305634 | 2025-11-24 13:55:28.305825 | TASK [validate-host : Collect information about the host] 2025-11-24 13:55:29.438796 | debian-bookworm | ok 2025-11-24 13:55:29.449091 | 2025-11-24 13:55:29.449218 | TASK [validate-host : Sanitize hostname] 2025-11-24 13:55:29.578297 | debian-bookworm | ok 2025-11-24 13:55:29.623774 | 2025-11-24 13:55:29.623926 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-24 13:55:30.197077 | debian-bookworm -> localhost | changed 2025-11-24 13:55:30.204266 | 2025-11-24 13:55:30.204399 | TASK [validate-host : Collect information about zuul worker] 2025-11-24 13:55:30.647216 | debian-bookworm | ok 2025-11-24 13:55:30.658534 | 2025-11-24 13:55:30.658721 | TASK [validate-host : Write out all zuul information for each host] 2025-11-24 13:55:31.242640 | debian-bookworm -> localhost | changed 2025-11-24 13:55:31.261335 | 2025-11-24 13:55:31.261501 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-11-24 13:55:31.538060 | debian-bookworm | ok 2025-11-24 13:55:31.547745 | 2025-11-24 13:55:31.547885 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-11-24 13:55:32.750064 | debian-bookworm | changed: 2025-11-24 13:55:32.750288 | debian-bookworm | cd+++++++++ src/ 2025-11-24 13:55:32.750325 | debian-bookworm | cd+++++++++ src/github.com/ 2025-11-24 13:55:32.750351 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-11-24 13:55:32.750373 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-inventory-reconciler/ 2025-11-24 13:55:32.750394 | debian-bookworm | Containerfile 2025-11-24 13:55:32.750528 | debian-bookworm | [builder 8/22] RUN <>> RUN <>> set -e 2025-11-24 13:56:41.616368 | debian-bookworm | 49 | >>> set -x 2025-11-24 13:56:41.616376 | debian-bookworm | 50 | >>> 2025-11-24 13:56:41.616383 | debian-bookworm | 51 | >>> git clone https://github.com/osism/release /release 2025-11-24 13:56:41.616391 | debian-bookworm | 52 | >>> git clone https://github.com/osism/defaults /defaults 2025-11-24 13:56:41.616398 | debian-bookworm | 53 | >>> git clone https://github.com/osism/cfg-generics /generics 2025-11-24 13:56:41.616405 | debian-bookworm | 54 | >>> 2025-11-24 13:56:41.616412 | debian-bookworm | 55 | >>> if [ "$VERSION" != "latest" ]; then 2025-11-24 13:56:41.616420 | debian-bookworm | 56 | >>> ( cd /release || exit; git fetch --all --force; git checkout "inventory-reconciler-$VERSION" ) 2025-11-24 13:56:41.616428 | debian-bookworm | 57 | >>> ( cd /defaults || exit; git fetch --all --force; git checkout "$(yq -M -r .defaults_version "/release/latest/base.yml")" ) 2025-11-24 13:56:41.616447 | debian-bookworm | 58 | >>> ( cd /generics || exit; git fetch --all --force; git checkout "$(yq -M -r .generics_version "/release/latest/base.yml")" ) 2025-11-24 13:56:41.616455 | debian-bookworm | 59 | >>> fi 2025-11-24 13:56:41.616462 | debian-bookworm | 60 | >>> EOF 2025-11-24 13:56:41.616559 | debian-bookworm | 61 | 2025-11-24 13:56:41.616569 | debian-bookworm | -------------------- 2025-11-24 13:56:41.616578 | 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-24 13:56:42.110490 | debian-bookworm | ERROR 2025-11-24 13:56:42.110733 | debian-bookworm | { 2025-11-24 13:56:42.110773 | debian-bookworm | "delta": "0:00:17.573142", 2025-11-24 13:56:42.110797 | debian-bookworm | "end": "2025-11-24 13:56:41.628240", 2025-11-24 13:56:42.110819 | debian-bookworm | "msg": "non-zero return code", 2025-11-24 13:56:42.111062 | debian-bookworm | "rc": 1, 2025-11-24 13:56:42.111083 | debian-bookworm | "start": "2025-11-24 13:56:24.055098" 2025-11-24 13:56:42.111106 | debian-bookworm | } failure 2025-11-24 13:56:42.115074 | 2025-11-24 13:56:42.115317 | PLAY RECAP 2025-11-24 13:56:42.115393 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-11-24 13:56:42.115419 | 2025-11-24 13:56:42.281413 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-inventory-reconciler/playbooks/build.yml@main] 2025-11-24 13:56:42.282518 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-24 13:56:43.086977 | 2025-11-24 13:56:43.087174 | PLAY [Base post] 2025-11-24 13:56:43.103655 | 2025-11-24 13:56:43.103840 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-24 13:56:43.893604 | debian-bookworm | changed 2025-11-24 13:56:43.903188 | 2025-11-24 13:56:43.903334 | PLAY RECAP 2025-11-24 13:56:43.903416 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-24 13:56:43.903495 | 2025-11-24 13:56:44.051395 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-11-24 13:56:44.052431 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-11-24 13:56:44.961860 | 2025-11-24 13:56:44.962047 | PLAY [Base post-logs] 2025-11-24 13:56:44.974012 | 2025-11-24 13:56:44.974169 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-24 13:56:45.484261 | localhost | changed 2025-11-24 13:56:45.512245 | 2025-11-24 13:56:45.512484 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-24 13:56:45.549622 | localhost | ok 2025-11-24 13:56:45.553773 | 2025-11-24 13:56:45.553905 | TASK [Set zuul-log-path fact] 2025-11-24 13:56:45.570075 | localhost | ok 2025-11-24 13:56:45.580165 | 2025-11-24 13:56:45.580308 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-24 13:56:45.608801 | localhost | ok 2025-11-24 13:56:45.616271 | 2025-11-24 13:56:45.616458 | TASK [upload-logs : Create log directories] 2025-11-24 13:56:46.123510 | localhost | changed 2025-11-24 13:56:46.126348 | 2025-11-24 13:56:46.126450 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-24 13:56:46.642986 | localhost -> localhost | ok: Runtime: 0:00:00.008579 2025-11-24 13:56:46.652187 | 2025-11-24 13:56:46.652393 | TASK [upload-logs : Upload logs to log server] 2025-11-24 13:56:47.238044 | localhost | Output suppressed because no_log was given 2025-11-24 13:56:47.242169 | 2025-11-24 13:56:47.242351 | LOOP [upload-logs : Compress console log and json output] 2025-11-24 13:56:47.312889 | localhost | skipping: Conditional result was False 2025-11-24 13:56:47.318902 | localhost | skipping: Conditional result was False 2025-11-24 13:56:47.330950 | 2025-11-24 13:56:47.331136 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-24 13:56:47.383087 | localhost | skipping: Conditional result was False 2025-11-24 13:56:47.383836 | 2025-11-24 13:56:47.388106 | localhost | skipping: Conditional result was False 2025-11-24 13:56:47.402194 | 2025-11-24 13:56:47.402409 | LOOP [upload-logs : Upload console log and json output]