2026-05-25 05:47:24.309188 | Job console starting 2026-05-25 05:47:24.332991 | Updating git repos 2026-05-25 05:47:24.417575 | Cloning repos into workspace 2026-05-25 05:47:24.477346 | Restoring repo states 2026-05-25 05:47:24.496010 | Merging changes 2026-05-25 05:47:25.171387 | Checking out repos 2026-05-25 05:47:25.268714 | Preparing playbooks 2026-05-25 05:47:27.000297 | Running Ansible setup 2026-05-25 05:47:33.431106 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-25 05:47:34.612080 | 2026-05-25 05:47:34.612203 | PLAY [Base pre] 2026-05-25 05:47:34.656388 | 2026-05-25 05:47:34.656511 | TASK [Setup log path fact] 2026-05-25 05:47:34.694812 | debian-bookworm | ok 2026-05-25 05:47:34.715670 | 2026-05-25 05:47:34.715791 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 05:47:34.752392 | debian-bookworm | ok 2026-05-25 05:47:34.772501 | 2026-05-25 05:47:34.772614 | TASK [emit-job-header : Print job information] 2026-05-25 05:47:34.830341 | # Job Information 2026-05-25 05:47:34.830523 | Ansible Version: 2.16.14 2026-05-25 05:47:34.830556 | Job: container-image-kolla-ansible-build-2025.2 2026-05-25 05:47:34.830583 | Pipeline: check 2026-05-25 05:47:34.830602 | Executor: 521e9411259a 2026-05-25 05:47:34.830620 | Triggered by: https://github.com/osism/container-image-kolla-ansible/pull/908 2026-05-25 05:47:34.830638 | Event ID: 2d6f4454-57fd-11f1-8df3-43cb83c222fa 2026-05-25 05:47:34.834526 | 2026-05-25 05:47:34.834610 | LOOP [emit-job-header : Print node information] 2026-05-25 05:47:34.955670 | debian-bookworm | ok: 2026-05-25 05:47:34.955813 | debian-bookworm | # Node Information 2026-05-25 05:47:34.955842 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-25 05:47:34.955864 | debian-bookworm | Hostname: debian 2026-05-25 05:47:34.955883 | debian-bookworm | Username: zuul 2026-05-25 05:47:34.955901 | debian-bookworm | Distro: Debian 12.14 2026-05-25 05:47:34.955921 | debian-bookworm | Provider: regiocloud-a 2026-05-25 05:47:34.955938 | debian-bookworm | Region: 2026-05-25 05:47:34.955956 | debian-bookworm | Label: debian-bookworm 2026-05-25 05:47:34.955972 | debian-bookworm | Product Name: OpenStack Nova 2026-05-25 05:47:34.955987 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7d:6bdd 2026-05-25 05:47:34.978464 | 2026-05-25 05:47:34.978606 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-25 05:47:35.697062 | debian-bookworm -> localhost | changed 2026-05-25 05:47:35.704192 | 2026-05-25 05:47:35.704302 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-25 05:47:37.035986 | debian-bookworm -> localhost | changed 2026-05-25 05:47:37.044559 | 2026-05-25 05:47:37.044655 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-25 05:47:37.479392 | debian-bookworm -> localhost | ok 2026-05-25 05:47:37.484324 | 2026-05-25 05:47:37.484413 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-25 05:47:37.522313 | debian-bookworm | ok 2026-05-25 05:47:37.556150 | debian-bookworm | included: /var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-25 05:47:37.561267 | 2026-05-25 05:47:37.561350 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-25 05:47:39.919130 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-25 05:47:39.919325 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/ec65647ff31c47888e59a277eea1e000_id_rsa 2026-05-25 05:47:39.919363 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/ec65647ff31c47888e59a277eea1e000_id_rsa.pub 2026-05-25 05:47:39.919391 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-25 05:47:39.919415 | debian-bookworm -> localhost | SHA256:a9st5ITWL4yk+c3Pz/6k/+REiDz3MwvVLF0scwTp/RA zuul-build-sshkey 2026-05-25 05:47:39.919447 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-25 05:47:39.919482 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-25 05:47:39.919505 | debian-bookworm -> localhost | | .o.| 2026-05-25 05:47:39.919526 | debian-bookworm -> localhost | | Eo | 2026-05-25 05:47:39.919546 | debian-bookworm -> localhost | | .oo+| 2026-05-25 05:47:39.919566 | debian-bookworm -> localhost | | . .oB+| 2026-05-25 05:47:39.919587 | debian-bookworm -> localhost | | So + +o*| 2026-05-25 05:47:39.919609 | debian-bookworm -> localhost | | +.+ o.+.| 2026-05-25 05:47:39.919629 | debian-bookworm -> localhost | | =o* . . o=| 2026-05-25 05:47:39.919649 | debian-bookworm -> localhost | | o..==o...*+| 2026-05-25 05:47:39.919669 | debian-bookworm -> localhost | | .o +++o=+*| 2026-05-25 05:47:39.919689 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-25 05:47:39.919741 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.473619 2026-05-25 05:47:39.926066 | 2026-05-25 05:47:39.926157 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-25 05:47:39.953603 | debian-bookworm | ok 2026-05-25 05:47:39.962311 | debian-bookworm | included: /var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-25 05:47:39.974784 | 2026-05-25 05:47:39.974893 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-25 05:47:39.997953 | debian-bookworm | skipping: Conditional result was False 2026-05-25 05:47:40.005880 | 2026-05-25 05:47:40.005982 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-25 05:47:40.612480 | debian-bookworm | changed 2026-05-25 05:47:40.617959 | 2026-05-25 05:47:40.618062 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-25 05:47:40.871548 | debian-bookworm | ok 2026-05-25 05:47:40.884935 | 2026-05-25 05:47:40.885054 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-25 05:47:41.522427 | debian-bookworm | changed 2026-05-25 05:47:41.528104 | 2026-05-25 05:47:41.528188 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-25 05:47:42.190255 | debian-bookworm | changed 2026-05-25 05:47:42.195606 | 2026-05-25 05:47:42.195697 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-25 05:47:42.218719 | debian-bookworm | skipping: Conditional result was False 2026-05-25 05:47:42.224837 | 2026-05-25 05:47:42.224939 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-25 05:47:42.732448 | debian-bookworm -> localhost | changed 2026-05-25 05:47:42.743027 | 2026-05-25 05:47:42.743134 | TASK [add-build-sshkey : Add back temp key] 2026-05-25 05:47:43.180234 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/ec65647ff31c47888e59a277eea1e000_id_rsa (zuul-build-sshkey) 2026-05-25 05:47:43.180455 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.022910 2026-05-25 05:47:43.188043 | 2026-05-25 05:47:43.188150 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-25 05:47:43.740993 | debian-bookworm | ok 2026-05-25 05:47:43.745888 | 2026-05-25 05:47:43.745980 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-25 05:47:43.768775 | debian-bookworm | skipping: Conditional result was False 2026-05-25 05:47:43.778871 | 2026-05-25 05:47:43.778985 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-25 05:47:44.193818 | debian-bookworm | ok 2026-05-25 05:47:44.206103 | 2026-05-25 05:47:44.206203 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-25 05:47:44.233735 | debian-bookworm | ok 2026-05-25 05:47:44.238575 | 2026-05-25 05:47:44.238667 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-25 05:47:44.537155 | debian-bookworm -> localhost | ok 2026-05-25 05:47:44.554112 | 2026-05-25 05:47:44.554233 | TASK [validate-host : Collect information about the host] 2026-05-25 05:47:45.639939 | debian-bookworm | ok 2026-05-25 05:47:45.650675 | 2026-05-25 05:47:45.650808 | TASK [validate-host : Sanitize hostname] 2026-05-25 05:47:45.787110 | debian-bookworm | ok 2026-05-25 05:47:45.844612 | 2026-05-25 05:47:45.844763 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-25 05:47:46.545367 | debian-bookworm -> localhost | changed 2026-05-25 05:47:46.553131 | 2026-05-25 05:47:46.553255 | TASK [validate-host : Collect information about zuul worker] 2026-05-25 05:47:47.017480 | debian-bookworm | ok 2026-05-25 05:47:47.023315 | 2026-05-25 05:47:47.023439 | TASK [validate-host : Write out all zuul information for each host] 2026-05-25 05:47:47.667237 | debian-bookworm -> localhost | changed 2026-05-25 05:47:47.677329 | 2026-05-25 05:47:47.677485 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-25 05:47:47.957246 | debian-bookworm | ok 2026-05-25 05:47:47.965789 | 2026-05-25 05:47:47.965951 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-25 05:47:48.814309 | debian-bookworm | changed: 2026-05-25 05:47:48.814552 | debian-bookworm | cd+++++++++ src/ 2026-05-25 05:47:48.814589 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-25 05:47:48.814614 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-25 05:47:48.814635 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-05-25 05:47:48.814655 | debian-bookworm | Containerfile 2026-05-25 05:47:48.814805 | debian-bookworm | [internal] load metadata for registry.osism.tech/dockerhub/python:3.13-slim-bookworm: 2026-05-25 05:48:43.749855 | debian-bookworm | ------ 2026-05-25 05:48:43.761826 | debian-bookworm | Dockerfile:4 2026-05-25 05:48:43.761898 | debian-bookworm | -------------------- 2026-05-25 05:48:43.761909 | debian-bookworm | 2 | ARG IMAGE=registry.osism.tech/dockerhub/python 2026-05-25 05:48:43.761918 | debian-bookworm | 3 | 2026-05-25 05:48:43.761927 | debian-bookworm | 4 | >>> FROM ${IMAGE}:${PYTHON_VERSION}-slim-bookworm AS builder 2026-05-25 05:48:43.761945 | debian-bookworm | 5 | 2026-05-25 05:48:43.761953 | debian-bookworm | 6 | ARG OPENSTACK_VERSION 2026-05-25 05:48:43.761961 | debian-bookworm | -------------------- 2026-05-25 05:48:43.761983 | debian-bookworm | ERROR: failed to build: failed to solve: registry.osism.tech/dockerhub/python:3.13-slim-bookworm: failed to resolve source metadata for registry.osism.tech/dockerhub/python:3.13-slim-bookworm: unexpected status from HEAD request to https://registry.osism.tech/v2/dockerhub/python/manifests/3.13-slim-bookworm: 503 Service Temporarily Unavailable 2026-05-25 05:48:43.875426 | debian-bookworm | ERROR 2026-05-25 05:48:43.875849 | debian-bookworm | { 2026-05-25 05:48:43.875953 | debian-bookworm | "delta": "0:00:00.659097", 2026-05-25 05:48:43.876044 | debian-bookworm | "end": "2026-05-25 05:48:43.772404", 2026-05-25 05:48:43.876140 | debian-bookworm | "msg": "non-zero return code", 2026-05-25 05:48:43.876239 | debian-bookworm | "rc": 1, 2026-05-25 05:48:43.876308 | debian-bookworm | "start": "2026-05-25 05:48:43.113307" 2026-05-25 05:48:43.876362 | debian-bookworm | } failure 2026-05-25 05:48:43.880664 | 2026-05-25 05:48:43.880815 | PLAY RECAP 2026-05-25 05:48:43.880937 | debian-bookworm | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 1 rescued: 0 ignored: 0 2026-05-25 05:48:43.880998 | 2026-05-25 05:48:44.043061 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2026-05-25 05:48:44.044989 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-25 05:48:45.042594 | 2026-05-25 05:48:45.042810 | PLAY [Base post-fetch] 2026-05-25 05:48:45.059345 | 2026-05-25 05:48:45.059598 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-25 05:48:45.126094 | debian-bookworm | skipping: Conditional result was False 2026-05-25 05:48:45.137296 | 2026-05-25 05:48:45.137665 | TASK [fetch-output : Set log path for single node] 2026-05-25 05:48:45.183721 | debian-bookworm | ok 2026-05-25 05:48:45.190913 | 2026-05-25 05:48:45.191079 | LOOP [fetch-output : Ensure local output dirs] 2026-05-25 05:48:45.716273 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/logs" 2026-05-25 05:48:45.991000 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/artifacts" 2026-05-25 05:48:46.260409 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/ec65647ff31c47888e59a277eea1e000/work/docs" 2026-05-25 05:48:46.276270 | 2026-05-25 05:48:46.276635 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-25 05:48:47.093229 | debian-bookworm | changed: 2026-05-25 05:48:47.093481 | debian-bookworm | .d..t...... ./ 2026-05-25 05:48:47.093518 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-25 05:48:47.093549 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-25 05:48:47.093576 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-25 05:48:47.093615 | debian-bookworm | changed: All items complete 2026-05-25 05:48:47.093637 | 2026-05-25 05:48:47.658114 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 05:48:48.232865 | debian-bookworm | changed: .d..t...... ./ 2026-05-25 05:48:48.251747 | 2026-05-25 05:48:48.251905 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-25 05:48:48.808976 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011510 2026-05-25 05:48:49.114053 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012932 2026-05-25 05:48:49.138099 | 2026-05-25 05:48:49.138242 | PLAY RECAP 2026-05-25 05:48:49.138327 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-25 05:48:49.138366 | 2026-05-25 05:48:49.272121 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-25 05:48:49.274242 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 05:48:50.090879 | 2026-05-25 05:48:50.091060 | PLAY [Base post] 2026-05-25 05:48:50.105872 | 2026-05-25 05:48:50.106025 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-25 05:48:50.928692 | debian-bookworm | changed 2026-05-25 05:48:50.948412 | 2026-05-25 05:48:50.948618 | PLAY RECAP 2026-05-25 05:48:50.948729 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-25 05:48:50.948841 | 2026-05-25 05:48:51.083831 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-25 05:48:51.084860 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-25 05:48:51.871164 | 2026-05-25 05:48:51.871365 | PLAY [Base post-logs] 2026-05-25 05:48:51.882414 | 2026-05-25 05:48:51.882584 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-25 05:48:52.357300 | localhost | changed 2026-05-25 05:48:52.368133 | 2026-05-25 05:48:52.368316 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-25 05:48:52.405081 | localhost | ok 2026-05-25 05:48:52.408832 | 2026-05-25 05:48:52.408941 | TASK [Set zuul-log-path fact] 2026-05-25 05:48:52.426290 | localhost | ok 2026-05-25 05:48:52.435089 | 2026-05-25 05:48:52.435208 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-25 05:48:52.463647 | localhost | ok 2026-05-25 05:48:52.472140 | 2026-05-25 05:48:52.472396 | TASK [upload-logs : Create log directories] 2026-05-25 05:48:52.952408 | localhost | changed 2026-05-25 05:48:52.956322 | 2026-05-25 05:48:52.956544 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-25 05:48:53.491834 | localhost -> localhost | ok: Runtime: 0:00:00.009913 2026-05-25 05:48:53.496282 | 2026-05-25 05:48:53.496411 | TASK [upload-logs : Upload logs to log server] 2026-05-25 05:48:54.152336 | localhost | Output suppressed because no_log was given 2026-05-25 05:48:54.155400 | 2026-05-25 05:48:54.155557 | LOOP [upload-logs : Compress console log and json output] 2026-05-25 05:48:54.210554 | localhost | skipping: Conditional result was False 2026-05-25 05:48:54.217450 | localhost | skipping: Conditional result was False 2026-05-25 05:48:54.224228 | 2026-05-25 05:48:54.224350 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-25 05:48:54.290916 | localhost | skipping: Conditional result was False 2026-05-25 05:48:54.291632 | 2026-05-25 05:48:54.296961 | localhost | skipping: Conditional result was False 2026-05-25 05:48:54.304778 | 2026-05-25 05:48:54.304912 | LOOP [upload-logs : Upload console log and json output]