2026-06-26 14:42:16.497233 | Job console starting 2026-06-26 14:42:16.511835 | Updating git repos 2026-06-26 14:42:16.561747 | Cloning repos into workspace 2026-06-26 14:42:16.606417 | Restoring repo states 2026-06-26 14:42:16.623069 | Merging changes 2026-06-26 14:42:16.623095 | Checking out repos 2026-06-26 14:42:16.702160 | Preparing playbooks 2026-06-26 14:42:17.708333 | Running Ansible setup 2026-06-26 14:42:22.388242 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-26 14:42:23.321200 | 2026-06-26 14:42:23.321376 | PLAY [Base pre] 2026-06-26 14:42:23.340859 | 2026-06-26 14:42:23.341039 | TASK [Setup log path fact] 2026-06-26 14:42:23.361089 | debian-bookworm | ok 2026-06-26 14:42:23.381014 | 2026-06-26 14:42:23.381242 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-26 14:42:23.428069 | debian-bookworm | ok 2026-06-26 14:42:23.447074 | 2026-06-26 14:42:23.447346 | TASK [emit-job-header : Print job information] 2026-06-26 14:42:23.511411 | # Job Information 2026-06-26 14:42:23.511638 | Ansible Version: 2.16.14 2026-06-26 14:42:23.511681 | Job: container-image-kolla-ansible-push-2025.2 2026-06-26 14:42:23.511723 | Pipeline: post 2026-06-26 14:42:23.511751 | Executor: 521e9411259a 2026-06-26 14:42:23.511776 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/cfdf2424d18d609fe3a008740aced8c94f363460 2026-06-26 14:42:23.511802 | Event ID: a2374d10-7169-11f1-91b4-d1c8a3d3afe6 2026-06-26 14:42:23.517430 | 2026-06-26 14:42:23.517551 | LOOP [emit-job-header : Print node information] 2026-06-26 14:42:23.636625 | debian-bookworm | ok: 2026-06-26 14:42:23.637059 | debian-bookworm | # Node Information 2026-06-26 14:42:23.637122 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-26 14:42:23.637150 | debian-bookworm | Hostname: debian 2026-06-26 14:42:23.637172 | debian-bookworm | Username: zuul 2026-06-26 14:42:23.637193 | debian-bookworm | Distro: Debian 12.14 2026-06-26 14:42:23.637217 | debian-bookworm | Provider: regiocloud-a 2026-06-26 14:42:23.637238 | debian-bookworm | Region: 2026-06-26 14:42:23.637260 | debian-bookworm | Label: debian-bookworm 2026-06-26 14:42:23.637280 | debian-bookworm | Product Name: OpenStack Nova 2026-06-26 14:42:23.637299 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe26:d4f9 2026-06-26 14:42:23.671925 | 2026-06-26 14:42:23.672135 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-26 14:42:24.237308 | debian-bookworm -> localhost | changed 2026-06-26 14:42:24.245532 | 2026-06-26 14:42:24.245664 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-26 14:42:25.926191 | debian-bookworm -> localhost | changed 2026-06-26 14:42:25.951169 | 2026-06-26 14:42:25.951320 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-26 14:42:26.645145 | debian-bookworm -> localhost | ok 2026-06-26 14:42:26.655281 | 2026-06-26 14:42:26.655476 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-26 14:42:26.705431 | debian-bookworm | ok 2026-06-26 14:42:26.734692 | debian-bookworm | included: /var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-26 14:42:26.741669 | 2026-06-26 14:42:26.741796 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-26 14:42:28.875774 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-26 14:42:28.876110 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/c3caa402b50341c5acd32f10229902f0_id_rsa 2026-06-26 14:42:28.876158 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/c3caa402b50341c5acd32f10229902f0_id_rsa.pub 2026-06-26 14:42:28.876186 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-26 14:42:28.876210 | debian-bookworm -> localhost | SHA256:WGttOsV2Y6OsY0c5M6hdjia/1+MM8KTXJkJLbtibNvE zuul-build-sshkey 2026-06-26 14:42:28.876247 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-26 14:42:28.876270 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-26 14:42:28.876292 | debian-bookworm -> localhost | | | 2026-06-26 14:42:28.876313 | debian-bookworm -> localhost | | | 2026-06-26 14:42:28.876334 | debian-bookworm -> localhost | | . | 2026-06-26 14:42:28.876354 | debian-bookworm -> localhost | | o + | 2026-06-26 14:42:28.876374 | debian-bookworm -> localhost | | . S.B.= | 2026-06-26 14:42:28.876397 | debian-bookworm -> localhost | | Bo%B= o | 2026-06-26 14:42:28.876419 | debian-bookworm -> localhost | | .oXBB=o | 2026-06-26 14:42:28.876438 | debian-bookworm -> localhost | | o.OBE=o | 2026-06-26 14:42:28.876459 | debian-bookworm -> localhost | | *** .o. | 2026-06-26 14:42:28.876479 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-26 14:42:28.876537 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.297204 2026-06-26 14:42:28.883602 | 2026-06-26 14:42:28.883749 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-26 14:42:28.917513 | debian-bookworm | ok 2026-06-26 14:42:28.936779 | debian-bookworm | included: /var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-26 14:42:28.950398 | 2026-06-26 14:42:28.950545 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-26 14:42:28.975168 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:42:28.982335 | 2026-06-26 14:42:28.982481 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-26 14:42:29.685837 | debian-bookworm | changed 2026-06-26 14:42:29.702021 | 2026-06-26 14:42:29.702186 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-26 14:42:30.025405 | debian-bookworm | ok 2026-06-26 14:42:30.031441 | 2026-06-26 14:42:30.031579 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-26 14:42:30.841123 | debian-bookworm | changed 2026-06-26 14:42:30.852704 | 2026-06-26 14:42:30.852855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-26 14:42:31.553897 | debian-bookworm | changed 2026-06-26 14:42:31.563250 | 2026-06-26 14:42:31.563388 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-26 14:42:31.587918 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:42:31.594416 | 2026-06-26 14:42:31.594531 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-26 14:42:32.204624 | debian-bookworm -> localhost | changed 2026-06-26 14:42:32.219943 | 2026-06-26 14:42:32.220102 | TASK [add-build-sshkey : Add back temp key] 2026-06-26 14:42:33.103110 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/c3caa402b50341c5acd32f10229902f0_id_rsa (zuul-build-sshkey) 2026-06-26 14:42:33.103383 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032727 2026-06-26 14:42:33.111935 | 2026-06-26 14:42:33.119083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-26 14:42:33.586733 | debian-bookworm | ok 2026-06-26 14:42:33.595808 | 2026-06-26 14:42:33.595941 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-26 14:42:33.644665 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:42:33.660599 | 2026-06-26 14:42:33.660754 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-26 14:42:34.141951 | debian-bookworm | ok 2026-06-26 14:42:34.166042 | 2026-06-26 14:42:34.166201 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-26 14:42:34.196621 | debian-bookworm | ok 2026-06-26 14:42:34.202421 | 2026-06-26 14:42:34.202565 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-26 14:42:34.504314 | debian-bookworm -> localhost | ok 2026-06-26 14:42:34.511590 | 2026-06-26 14:42:34.511716 | TASK [validate-host : Collect information about the host] 2026-06-26 14:42:35.768157 | debian-bookworm | ok 2026-06-26 14:42:35.780709 | 2026-06-26 14:42:35.780916 | TASK [validate-host : Sanitize hostname] 2026-06-26 14:42:35.936629 | debian-bookworm | ok 2026-06-26 14:42:35.941466 | 2026-06-26 14:42:35.941580 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-26 14:42:36.931764 | debian-bookworm -> localhost | changed 2026-06-26 14:42:36.937926 | 2026-06-26 14:42:36.938068 | TASK [validate-host : Collect information about zuul worker] 2026-06-26 14:42:37.442533 | debian-bookworm | ok 2026-06-26 14:42:37.448200 | 2026-06-26 14:42:37.448395 | TASK [validate-host : Write out all zuul information for each host] 2026-06-26 14:42:38.199793 | debian-bookworm -> localhost | changed 2026-06-26 14:42:38.210732 | 2026-06-26 14:42:38.210886 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-26 14:42:38.514649 | debian-bookworm | ok 2026-06-26 14:42:38.521165 | 2026-06-26 14:42:38.521295 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-26 14:42:39.646606 | debian-bookworm | changed: 2026-06-26 14:42:39.647389 | debian-bookworm | cd+++++++++ src/ 2026-06-26 14:42:39.647465 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-26 14:42:39.647511 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-26 14:42:39.647552 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2026-06-26 14:42:39.647589 | debian-bookworm | Containerfile 2026-06-26 14:42:39.647857 | debian-bookworm | {"status":400,"title":"The uploaded BOM is invalid","detail":"Unrecognized specVersion 1.7"} 2026-06-26 14:48:40.473120 | debian-bookworm | ERROR 2026-06-26 14:48:40.473603 | debian-bookworm | { 2026-06-26 14:48:40.473763 | debian-bookworm | "delta": "0:00:34.306461", 2026-06-26 14:48:40.473861 | debian-bookworm | "end": "2026-06-26 14:48:40.012254", 2026-06-26 14:48:40.474118 | debian-bookworm | "msg": "non-zero return code", 2026-06-26 14:48:40.474198 | debian-bookworm | "rc": 1, 2026-06-26 14:48:40.474259 | debian-bookworm | "start": "2026-06-26 14:48:05.705793" 2026-06-26 14:48:40.474315 | debian-bookworm | } failure 2026-06-26 14:48:40.478228 | 2026-06-26 14:48:40.478350 | PLAY RECAP 2026-06-26 14:48:40.478458 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-06-26 14:48:40.478528 | 2026-06-26 14:48:40.664028 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2026-06-26 14:48:40.665802 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-26 14:48:41.469896 | 2026-06-26 14:48:41.470136 | PLAY [Base post-fetch] 2026-06-26 14:48:41.485805 | 2026-06-26 14:48:41.486011 | TASK [diagnose-network : Ensure log directory exists] 2026-06-26 14:48:42.194188 | debian-bookworm | ok 2026-06-26 14:48:42.205606 | 2026-06-26 14:48:42.205807 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-26 14:48:54.056266 | debian-bookworm | ok: Runtime: 0:00:05.917842 2026-06-26 14:48:54.069045 | 2026-06-26 14:48:54.069226 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-26 14:49:00.153913 | debian-bookworm | ok: Runtime: 0:00:00.426771 2026-06-26 14:49:00.162130 | 2026-06-26 14:49:00.162291 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-26 14:49:06.251686 | debian-bookworm | ok: Runtime: 0:00:01.421650 2026-06-26 14:49:06.264920 | 2026-06-26 14:49:06.265198 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-26 14:49:06.327580 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:49:06.335152 | 2026-06-26 14:49:06.335346 | TASK [fetch-output : Set log path for single node] 2026-06-26 14:49:06.389816 | debian-bookworm | ok 2026-06-26 14:49:06.395460 | 2026-06-26 14:49:06.395607 | LOOP [fetch-output : Ensure local output dirs] 2026-06-26 14:49:06.735294 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/logs" 2026-06-26 14:49:07.015185 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/artifacts" 2026-06-26 14:49:07.325134 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c3caa402b50341c5acd32f10229902f0/work/docs" 2026-06-26 14:49:07.344568 | 2026-06-26 14:49:07.344757 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-26 14:49:08.220808 | debian-bookworm | changed: 2026-06-26 14:49:08.221229 | debian-bookworm | .d..t...... ./ 2026-06-26 14:49:08.221284 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-26 14:49:08.221311 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-26 14:49:08.221333 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-26 14:49:08.221354 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-26 14:49:08.221375 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-26 14:49:08.221422 | debian-bookworm | changed: All items complete 2026-06-26 14:49:08.221446 | 2026-06-26 14:49:08.833109 | debian-bookworm | changed: .d..t...... ./ 2026-06-26 14:49:09.415228 | debian-bookworm | changed: .d..t...... ./ 2026-06-26 14:49:09.447590 | 2026-06-26 14:49:09.447799 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-26 14:49:09.486439 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:49:09.489644 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:49:09.502891 | 2026-06-26 14:49:09.503071 | PLAY RECAP 2026-06-26 14:49:09.503132 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-06-26 14:49:09.503158 | 2026-06-26 14:49:09.664732 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-26 14:49:09.667338 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-26 14:49:10.437211 | 2026-06-26 14:49:10.437398 | PLAY [Base post] 2026-06-26 14:49:10.452387 | 2026-06-26 14:49:10.452537 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-26 14:49:11.313278 | debian-bookworm | changed 2026-06-26 14:49:11.323303 | 2026-06-26 14:49:11.323468 | PLAY RECAP 2026-06-26 14:49:11.323565 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-26 14:49:11.323654 | 2026-06-26 14:49:11.482819 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-26 14:49:11.483993 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-26 14:49:12.316089 | 2026-06-26 14:49:12.316351 | PLAY [Base post-logs] 2026-06-26 14:49:12.329001 | 2026-06-26 14:49:12.329193 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-26 14:49:12.838365 | localhost | changed 2026-06-26 14:49:12.853149 | 2026-06-26 14:49:12.853348 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-26 14:49:12.892999 | localhost | ok 2026-06-26 14:49:12.899587 | 2026-06-26 14:49:12.899714 | TASK [Set zuul-log-path fact] 2026-06-26 14:49:12.918759 | localhost | ok 2026-06-26 14:49:12.927565 | 2026-06-26 14:49:12.927681 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-26 14:49:12.953993 | localhost | ok 2026-06-26 14:49:12.957832 | 2026-06-26 14:49:12.957998 | TASK [upload-logs : Create log directories] 2026-06-26 14:49:13.511040 | localhost | changed 2026-06-26 14:49:13.516348 | 2026-06-26 14:49:13.516517 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-26 14:49:14.067581 | localhost -> localhost | ok: Runtime: 0:00:00.008367 2026-06-26 14:49:14.076656 | 2026-06-26 14:49:14.076838 | TASK [upload-logs : Upload logs to log server] 2026-06-26 14:49:14.684788 | localhost | Output suppressed because no_log was given 2026-06-26 14:49:14.689158 | 2026-06-26 14:49:14.689352 | LOOP [upload-logs : Compress console log and json output] 2026-06-26 14:49:14.750753 | localhost | skipping: Conditional result was False 2026-06-26 14:49:14.756446 | localhost | skipping: Conditional result was False 2026-06-26 14:49:14.765831 | 2026-06-26 14:49:14.766092 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-26 14:49:14.814166 | localhost | skipping: Conditional result was False 2026-06-26 14:49:14.814613 | 2026-06-26 14:49:14.819397 | localhost | skipping: Conditional result was False 2026-06-26 14:49:14.825831 | 2026-06-26 14:49:14.825978 | LOOP [upload-logs : Upload console log and json output]