2025-08-22 00:00:08.491855 | Job console starting 2025-08-22 00:00:08.529705 | Updating git repos 2025-08-22 00:00:08.778939 | Cloning repos into workspace 2025-08-22 00:00:08.835989 | Restoring repo states 2025-08-22 00:00:08.853556 | Merging changes 2025-08-22 00:00:08.853573 | Checking out repos 2025-08-22 00:00:08.920446 | Preparing playbooks 2025-08-22 00:00:09.637562 | Running Ansible setup 2025-08-22 00:00:14.371882 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-22 00:00:15.403578 | 2025-08-22 00:00:15.403749 | PLAY [Base pre] 2025-08-22 00:00:15.422027 | 2025-08-22 00:00:15.422150 | TASK [Setup log path fact] 2025-08-22 00:00:15.451250 | debian-bookworm | ok 2025-08-22 00:00:15.467038 | 2025-08-22 00:00:15.467164 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-22 00:00:15.508252 | debian-bookworm | ok 2025-08-22 00:00:15.523608 | 2025-08-22 00:00:15.523783 | TASK [emit-job-header : Print job information] 2025-08-22 00:00:15.563749 | # Job Information 2025-08-22 00:00:15.564015 | Ansible Version: 2.16.14 2025-08-22 00:00:15.564056 | Job: container-image-kolla-ansible-push-2024.1 2025-08-22 00:00:15.564091 | Pipeline: periodic-midnight 2025-08-22 00:00:15.564114 | Executor: 521e9411259a 2025-08-22 00:00:15.564135 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-08-22 00:00:15.564158 | Event ID: 98a86427fc26414c80a14b1ce23aea24 2025-08-22 00:00:15.569772 | 2025-08-22 00:00:15.569880 | LOOP [emit-job-header : Print node information] 2025-08-22 00:00:15.692996 | debian-bookworm | ok: 2025-08-22 00:00:15.693160 | debian-bookworm | # Node Information 2025-08-22 00:00:15.693194 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-22 00:00:15.693220 | debian-bookworm | Hostname: debian 2025-08-22 00:00:15.693243 | debian-bookworm | Username: zuul 2025-08-22 00:00:15.693264 | debian-bookworm | Distro: Debian 12.11 2025-08-22 00:00:15.693299 | debian-bookworm | Provider: regiocloud-a 2025-08-22 00:00:15.693323 | debian-bookworm | Region: 2025-08-22 00:00:15.693344 | debian-bookworm | Label: debian-bookworm 2025-08-22 00:00:15.693364 | debian-bookworm | Product Name: OpenStack Nova 2025-08-22 00:00:15.693384 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fea5:1821 2025-08-22 00:00:15.716401 | 2025-08-22 00:00:15.716522 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-22 00:00:16.827474 | debian-bookworm -> localhost | changed 2025-08-22 00:00:16.835817 | 2025-08-22 00:00:16.835924 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-22 00:00:19.120310 | debian-bookworm -> localhost | changed 2025-08-22 00:00:19.130034 | 2025-08-22 00:00:19.130120 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-22 00:00:19.694751 | debian-bookworm -> localhost | ok 2025-08-22 00:00:19.700000 | 2025-08-22 00:00:19.700091 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-22 00:00:19.727171 | debian-bookworm | ok 2025-08-22 00:00:19.758400 | debian-bookworm | included: /var/lib/zuul/builds/ac77a878486c440fbedf6006f95ed43c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-22 00:00:19.764041 | 2025-08-22 00:00:19.764129 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-22 00:00:21.410459 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-22 00:00:21.410626 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/ac77a878486c440fbedf6006f95ed43c/work/ac77a878486c440fbedf6006f95ed43c_id_rsa 2025-08-22 00:00:21.410657 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/ac77a878486c440fbedf6006f95ed43c/work/ac77a878486c440fbedf6006f95ed43c_id_rsa.pub 2025-08-22 00:00:21.410679 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-22 00:00:21.410699 | debian-bookworm -> localhost | SHA256:WKNEt+YmwiMCEo2EI2Cd20NaT6CEYqyIamW/jkedoqk zuul-build-sshkey 2025-08-22 00:00:21.410724 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-22 00:00:21.410742 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-22 00:00:21.410759 | debian-bookworm -> localhost | |B=o...o . | 2025-08-22 00:00:21.410778 | debian-bookworm -> localhost | |B=oo.+ o . | 2025-08-22 00:00:21.410795 | debian-bookworm -> localhost | |X. .* + = | 2025-08-22 00:00:21.410812 | debian-bookworm -> localhost | |* * + B . | 2025-08-22 00:00:21.410828 | debian-bookworm -> localhost | |o + = * S | 2025-08-22 00:00:21.410859 | debian-bookworm -> localhost | |.o . * = | 2025-08-22 00:00:21.410876 | debian-bookworm -> localhost | |. + o | 2025-08-22 00:00:21.410892 | debian-bookworm -> localhost | | o.o | 2025-08-22 00:00:21.410910 | debian-bookworm -> localhost | | E..o. | 2025-08-22 00:00:21.410926 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-22 00:00:21.410967 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.565184 2025-08-22 00:00:21.421186 | 2025-08-22 00:00:21.421275 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-22 00:00:21.452382 | debian-bookworm | ok 2025-08-22 00:00:21.489100 | debian-bookworm | included: /var/lib/zuul/builds/ac77a878486c440fbedf6006f95ed43c/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-22 00:00:21.520209 | 2025-08-22 00:00:21.520313 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-22 00:00:21.576864 | debian-bookworm | skipping: Conditional result was False 2025-08-22 00:00:21.581673 | 2025-08-22 00:00:21.581754 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-22 00:00:22.453629 | debian-bookworm | changed 2025-08-22 00:00:22.458043 | 2025-08-22 00:00:22.458114 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-22 00:00:22.758982 | debian-bookworm | ok 2025-08-22 00:00:22.763531 | 2025-08-22 00:00:22.763606 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-22 00:00:23.499383 | debian-bookworm | changed 2025-08-22 00:00:23.504764 | 2025-08-22 00:00:23.504847 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-22 00:00:24.209372 | debian-bookworm | changed 2025-08-22 00:00:24.214221 | 2025-08-22 00:00:24.214307 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-22 00:00:24.247836 | debian-bookworm | skipping: Conditional result was False 2025-08-22 00:00:24.253757 | 2025-08-22 00:00:24.253839 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-22 00:00:24.972755 | debian-bookworm -> localhost | changed 2025-08-22 00:00:24.982643 | 2025-08-22 00:00:24.982734 | TASK [add-build-sshkey : Add back temp key] 2025-08-22 00:00:25.940324 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/ac77a878486c440fbedf6006f95ed43c/work/ac77a878486c440fbedf6006f95ed43c_id_rsa (zuul-build-sshkey) 2025-08-22 00:00:25.940508 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.038721 2025-08-22 00:00:25.946962 | 2025-08-22 00:00:25.947041 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-22 00:00:26.732316 | debian-bookworm | ok 2025-08-22 00:00:26.736487 | 2025-08-22 00:00:26.736558 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-22 00:00:26.780428 | debian-bookworm | skipping: Conditional result was False 2025-08-22 00:00:26.789620 | 2025-08-22 00:00:26.789712 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-22 00:00:27.330369 | debian-bookworm | ok 2025-08-22 00:00:27.340651 | 2025-08-22 00:00:27.340744 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-22 00:00:27.379199 | debian-bookworm | ok 2025-08-22 00:00:27.383452 | 2025-08-22 00:00:27.383526 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-22 00:00:27.906194 | debian-bookworm -> localhost | ok 2025-08-22 00:00:27.911847 | 2025-08-22 00:00:27.911937 | TASK [validate-host : Collect information about the host] 2025-08-22 00:00:29.026257 | debian-bookworm | ok 2025-08-22 00:00:29.041992 | 2025-08-22 00:00:29.042087 | TASK [validate-host : Sanitize hostname] 2025-08-22 00:00:29.190553 | debian-bookworm | ok 2025-08-22 00:00:29.240475 | 2025-08-22 00:00:29.240567 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-22 00:00:30.687159 | debian-bookworm -> localhost | changed 2025-08-22 00:00:30.691900 | 2025-08-22 00:00:30.691983 | TASK [validate-host : Collect information about zuul worker] 2025-08-22 00:00:31.288404 | debian-bookworm | ok 2025-08-22 00:00:31.292999 | 2025-08-22 00:00:31.293089 | TASK [validate-host : Write out all zuul information for each host] 2025-08-22 00:00:32.619693 | debian-bookworm -> localhost | changed 2025-08-22 00:00:32.629033 | 2025-08-22 00:00:32.629127 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-22 00:00:32.894038 | debian-bookworm | ok 2025-08-22 00:00:32.899407 | 2025-08-22 00:00:32.899494 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-22 00:00:34.071081 | debian-bookworm | changed: 2025-08-22 00:00:34.071232 | debian-bookworm | cd+++++++++ src/ 2025-08-22 00:00:34.071261 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-22 00:00:34.071316 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-22 00:00:34.071336 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-08-22 00:00:34.071354 | debian-bookworm | Containerfile 2025-08-22 00:00:34.071466 | debian-bookworm | 2025-08-22 00:08:07.544855 | debian-bookworm | ERROR 2025-08-22 00:08:07.545196 | debian-bookworm | { 2025-08-22 00:08:07.545273 | debian-bookworm | "delta": "0:00:19.389627", 2025-08-22 00:08:07.545321 | debian-bookworm | "end": "2025-08-22 00:08:07.166157", 2025-08-22 00:08:07.545369 | debian-bookworm | "msg": "non-zero return code", 2025-08-22 00:08:07.545411 | debian-bookworm | "rc": 1, 2025-08-22 00:08:07.545451 | debian-bookworm | "start": "2025-08-22 00:07:47.776530" 2025-08-22 00:08:07.545487 | debian-bookworm | } failure 2025-08-22 00:08:07.551347 | 2025-08-22 00:08:07.551545 | PLAY RECAP 2025-08-22 00:08:07.551697 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-22 00:08:07.551768 | 2025-08-22 00:08:07.704872 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-08-22 00:08:07.705993 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-22 00:08:08.423154 | 2025-08-22 00:08:08.423305 | PLAY [Base post] 2025-08-22 00:08:08.437000 | 2025-08-22 00:08:08.437117 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-22 00:08:09.286889 | debian-bookworm | changed 2025-08-22 00:08:09.296061 | 2025-08-22 00:08:09.296186 | PLAY RECAP 2025-08-22 00:08:09.296259 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-22 00:08:09.296332 | 2025-08-22 00:08:09.409465 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-22 00:08:09.410544 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-22 00:08:10.190403 | 2025-08-22 00:08:10.190568 | PLAY [Base post-logs] 2025-08-22 00:08:10.201767 | 2025-08-22 00:08:10.201901 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-22 00:08:10.667999 | localhost | changed 2025-08-22 00:08:10.687329 | 2025-08-22 00:08:10.687548 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-22 00:08:10.726315 | localhost | ok 2025-08-22 00:08:10.732622 | 2025-08-22 00:08:10.732776 | TASK [Set zuul-log-path fact] 2025-08-22 00:08:10.750066 | localhost | ok 2025-08-22 00:08:10.761872 | 2025-08-22 00:08:10.762059 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-22 00:08:10.798984 | localhost | ok 2025-08-22 00:08:10.804862 | 2025-08-22 00:08:10.805042 | TASK [upload-logs : Create log directories] 2025-08-22 00:08:11.305389 | localhost | changed 2025-08-22 00:08:11.310725 | 2025-08-22 00:08:11.311014 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-22 00:08:11.824367 | localhost -> localhost | ok: Runtime: 0:00:00.008039 2025-08-22 00:08:11.829895 | 2025-08-22 00:08:11.830040 | TASK [upload-logs : Upload logs to log server] 2025-08-22 00:08:12.394280 | localhost | Output suppressed because no_log was given 2025-08-22 00:08:12.396711 | 2025-08-22 00:08:12.396831 | LOOP [upload-logs : Compress console log and json output] 2025-08-22 00:08:12.448535 | localhost | skipping: Conditional result was False 2025-08-22 00:08:12.453561 | localhost | skipping: Conditional result was False 2025-08-22 00:08:12.466266 | 2025-08-22 00:08:12.466448 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-22 00:08:12.511313 | localhost | skipping: Conditional result was False 2025-08-22 00:08:12.511999 | 2025-08-22 00:08:12.515370 | localhost | skipping: Conditional result was False 2025-08-22 00:08:12.528674 | 2025-08-22 00:08:12.528885 | LOOP [upload-logs : Upload console log and json output]