2025-09-06 00:00:04.512725 | Job console starting 2025-09-06 00:00:04.541787 | Updating git repos 2025-09-06 00:00:04.570824 | Cloning repos into workspace 2025-09-06 00:00:04.638987 | Restoring repo states 2025-09-06 00:00:04.650333 | Merging changes 2025-09-06 00:00:04.650349 | Checking out repos 2025-09-06 00:00:04.697405 | Preparing playbooks 2025-09-06 00:00:05.346787 | Running Ansible setup 2025-09-06 00:00:10.051275 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-06 00:00:11.093166 | 2025-09-06 00:00:11.093299 | PLAY [Base pre] 2025-09-06 00:00:11.146155 | 2025-09-06 00:00:11.156809 | TASK [Setup log path fact] 2025-09-06 00:00:11.185851 | debian-bookworm | ok 2025-09-06 00:00:11.213638 | 2025-09-06 00:00:11.213820 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-06 00:00:11.306692 | debian-bookworm | ok 2025-09-06 00:00:11.325034 | 2025-09-06 00:00:11.325140 | TASK [emit-job-header : Print job information] 2025-09-06 00:00:11.426979 | # Job Information 2025-09-06 00:00:11.427139 | Ansible Version: 2.16.14 2025-09-06 00:00:11.427174 | Job: container-image-kolla-ansible-push-2024.2 2025-09-06 00:00:11.427207 | Pipeline: periodic-midnight 2025-09-06 00:00:11.427229 | Executor: 521e9411259a 2025-09-06 00:00:11.427250 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-06 00:00:11.427271 | Event ID: 3bbec99a56344c23b57aa8f172ea19c6 2025-09-06 00:00:11.435282 | 2025-09-06 00:00:11.435406 | LOOP [emit-job-header : Print node information] 2025-09-06 00:00:11.810579 | debian-bookworm | ok: 2025-09-06 00:00:11.810799 | debian-bookworm | # Node Information 2025-09-06 00:00:11.810853 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-06 00:00:11.810880 | debian-bookworm | Hostname: debian 2025-09-06 00:00:11.810902 | debian-bookworm | Username: zuul 2025-09-06 00:00:11.810948 | debian-bookworm | Distro: Debian 12.11 2025-09-06 00:00:11.810974 | debian-bookworm | Provider: regiocloud-a 2025-09-06 00:00:11.810994 | debian-bookworm | Region: 2025-09-06 00:00:11.811016 | debian-bookworm | Label: debian-bookworm 2025-09-06 00:00:11.811035 | debian-bookworm | Product Name: OpenStack Nova 2025-09-06 00:00:11.811055 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe2d:82f6 2025-09-06 00:00:11.847041 | 2025-09-06 00:00:11.847254 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-06 00:00:12.835723 | debian-bookworm -> localhost | changed 2025-09-06 00:00:12.851037 | 2025-09-06 00:00:12.851144 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-06 00:00:14.334857 | debian-bookworm -> localhost | changed 2025-09-06 00:00:14.367057 | 2025-09-06 00:00:14.367175 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-06 00:00:15.287680 | debian-bookworm -> localhost | ok 2025-09-06 00:00:15.293559 | 2025-09-06 00:00:15.293661 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-06 00:00:15.353997 | debian-bookworm | ok 2025-09-06 00:00:15.391270 | debian-bookworm | included: /var/lib/zuul/builds/6e7675ddf859484fb602013fa700cf34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-06 00:00:15.401990 | 2025-09-06 00:00:15.402085 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-06 00:00:18.035279 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-06 00:00:18.035450 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6e7675ddf859484fb602013fa700cf34/work/6e7675ddf859484fb602013fa700cf34_id_rsa 2025-09-06 00:00:18.035482 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6e7675ddf859484fb602013fa700cf34/work/6e7675ddf859484fb602013fa700cf34_id_rsa.pub 2025-09-06 00:00:18.035504 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-06 00:00:18.035524 | debian-bookworm -> localhost | SHA256:fugbCmL2dLCBUo/DAYLhzA5VGiqqq48oWTEtatWQRhs zuul-build-sshkey 2025-09-06 00:00:18.035552 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-06 00:00:18.035570 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-06 00:00:18.035588 | debian-bookworm -> localhost | |=.+Eo | 2025-09-06 00:00:18.035605 | debian-bookworm -> localhost | |*+ *o | 2025-09-06 00:00:18.035621 | debian-bookworm -> localhost | |++=oo | 2025-09-06 00:00:18.035637 | debian-bookworm -> localhost | |=o+*.. | 2025-09-06 00:00:18.035653 | debian-bookworm -> localhost | |oo*++ S | 2025-09-06 00:00:18.035673 | debian-bookworm -> localhost | |oo.. + . . | 2025-09-06 00:00:18.035690 | debian-bookworm -> localhost | |oo+ + . + . | 2025-09-06 00:00:18.035706 | debian-bookworm -> localhost | |+= + o o o | 2025-09-06 00:00:18.035722 | debian-bookworm -> localhost | |B.. . . o. | 2025-09-06 00:00:18.035738 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-06 00:00:18.035781 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.508163 2025-09-06 00:00:18.041241 | 2025-09-06 00:00:18.041404 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-06 00:00:18.089958 | debian-bookworm | ok 2025-09-06 00:00:18.110816 | debian-bookworm | included: /var/lib/zuul/builds/6e7675ddf859484fb602013fa700cf34/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-06 00:00:18.134565 | 2025-09-06 00:00:18.134659 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-06 00:00:18.168141 | debian-bookworm | skipping: Conditional result was False 2025-09-06 00:00:18.172948 | 2025-09-06 00:00:18.173034 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-06 00:00:19.146188 | debian-bookworm | changed 2025-09-06 00:00:19.150484 | 2025-09-06 00:00:19.150567 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-06 00:00:19.413553 | debian-bookworm | ok 2025-09-06 00:00:19.418473 | 2025-09-06 00:00:19.418553 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-06 00:00:20.212486 | debian-bookworm | changed 2025-09-06 00:00:20.217888 | 2025-09-06 00:00:20.217994 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-06 00:00:20.931252 | debian-bookworm | changed 2025-09-06 00:00:20.935745 | 2025-09-06 00:00:20.935831 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-06 00:00:21.001129 | debian-bookworm | skipping: Conditional result was False 2025-09-06 00:00:21.006725 | 2025-09-06 00:00:21.006820 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-06 00:00:22.090794 | debian-bookworm -> localhost | changed 2025-09-06 00:00:22.099819 | 2025-09-06 00:00:22.099928 | TASK [add-build-sshkey : Add back temp key] 2025-09-06 00:00:23.152147 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6e7675ddf859484fb602013fa700cf34/work/6e7675ddf859484fb602013fa700cf34_id_rsa (zuul-build-sshkey) 2025-09-06 00:00:23.152326 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030750 2025-09-06 00:00:23.159527 | 2025-09-06 00:00:23.159612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-06 00:00:23.580568 | debian-bookworm | ok 2025-09-06 00:00:23.584573 | 2025-09-06 00:00:23.584643 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-06 00:00:23.619214 | debian-bookworm | skipping: Conditional result was False 2025-09-06 00:00:23.636512 | 2025-09-06 00:00:23.636602 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-06 00:00:24.230446 | debian-bookworm | ok 2025-09-06 00:00:24.245808 | 2025-09-06 00:00:24.245902 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-06 00:00:24.299846 | debian-bookworm | ok 2025-09-06 00:00:24.304362 | 2025-09-06 00:00:24.304446 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-06 00:00:25.149729 | debian-bookworm -> localhost | ok 2025-09-06 00:00:25.154901 | 2025-09-06 00:00:25.155008 | TASK [validate-host : Collect information about the host] 2025-09-06 00:00:27.011099 | debian-bookworm | ok 2025-09-06 00:00:27.026747 | 2025-09-06 00:00:27.026880 | TASK [validate-host : Sanitize hostname] 2025-09-06 00:00:27.153327 | debian-bookworm | ok 2025-09-06 00:00:27.202770 | 2025-09-06 00:00:27.202886 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-06 00:00:28.381947 | debian-bookworm -> localhost | changed 2025-09-06 00:00:28.387624 | 2025-09-06 00:00:28.387718 | TASK [validate-host : Collect information about zuul worker] 2025-09-06 00:00:28.914707 | debian-bookworm | ok 2025-09-06 00:00:28.918341 | 2025-09-06 00:00:28.918412 | TASK [validate-host : Write out all zuul information for each host] 2025-09-06 00:00:30.237937 | debian-bookworm -> localhost | changed 2025-09-06 00:00:30.245830 | 2025-09-06 00:00:30.245942 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-06 00:00:30.552393 | debian-bookworm | ok 2025-09-06 00:00:30.556721 | 2025-09-06 00:00:30.556804 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-06 00:00:32.022522 | debian-bookworm | changed: 2025-09-06 00:00:32.022659 | debian-bookworm | cd+++++++++ src/ 2025-09-06 00:00:32.022686 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-06 00:00:32.022706 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-06 00:00:32.022723 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-06 00:00:32.022740 | debian-bookworm | Containerfile 2025-09-06 00:00:32.022878 | debian-bookworm | 2025-09-06 00:06:11.535225 | debian-bookworm | ERROR 2025-09-06 00:06:11.535669 | debian-bookworm | { 2025-09-06 00:06:11.535812 | debian-bookworm | "delta": "0:00:20.804807", 2025-09-06 00:06:11.535885 | debian-bookworm | "end": "2025-09-06 00:06:11.106773", 2025-09-06 00:06:11.535958 | debian-bookworm | "msg": "non-zero return code", 2025-09-06 00:06:11.536018 | debian-bookworm | "rc": 1, 2025-09-06 00:06:11.536072 | debian-bookworm | "start": "2025-09-06 00:05:50.301966" 2025-09-06 00:06:11.536237 | debian-bookworm | } failure 2025-09-06 00:06:11.540644 | 2025-09-06 00:06:11.540880 | PLAY RECAP 2025-09-06 00:06:11.541010 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-06 00:06:11.541073 | 2025-09-06 00:06:11.689179 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-06 00:06:11.690367 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-06 00:06:12.461036 | 2025-09-06 00:06:12.461201 | PLAY [Base post] 2025-09-06 00:06:12.475296 | 2025-09-06 00:06:12.475444 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-06 00:06:13.325148 | debian-bookworm | changed 2025-09-06 00:06:13.333385 | 2025-09-06 00:06:13.333506 | PLAY RECAP 2025-09-06 00:06:13.333584 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-06 00:06:13.333665 | 2025-09-06 00:06:13.452621 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-06 00:06:13.453720 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-06 00:06:14.321373 | 2025-09-06 00:06:14.321543 | PLAY [Base post-logs] 2025-09-06 00:06:14.332521 | 2025-09-06 00:06:14.332656 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-06 00:06:14.867997 | localhost | changed 2025-09-06 00:06:14.878176 | 2025-09-06 00:06:14.878314 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-06 00:06:14.926467 | localhost | ok 2025-09-06 00:06:14.931883 | 2025-09-06 00:06:14.932041 | TASK [Set zuul-log-path fact] 2025-09-06 00:06:14.960744 | localhost | ok 2025-09-06 00:06:14.974928 | 2025-09-06 00:06:14.975061 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-06 00:06:15.012847 | localhost | ok 2025-09-06 00:06:15.020223 | 2025-09-06 00:06:15.020413 | TASK [upload-logs : Create log directories] 2025-09-06 00:06:15.551340 | localhost | changed 2025-09-06 00:06:15.556291 | 2025-09-06 00:06:15.556448 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-06 00:06:16.078770 | localhost -> localhost | ok: Runtime: 0:00:00.007169 2025-09-06 00:06:16.086388 | 2025-09-06 00:06:16.086572 | TASK [upload-logs : Upload logs to log server] 2025-09-06 00:06:16.636132 | localhost | Output suppressed because no_log was given 2025-09-06 00:06:16.640047 | 2025-09-06 00:06:16.640291 | LOOP [upload-logs : Compress console log and json output] 2025-09-06 00:06:16.697780 | localhost | skipping: Conditional result was False 2025-09-06 00:06:16.701231 | localhost | skipping: Conditional result was False 2025-09-06 00:06:16.716368 | 2025-09-06 00:06:16.716618 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-06 00:06:16.785236 | localhost | skipping: Conditional result was False 2025-09-06 00:06:16.785856 | 2025-09-06 00:06:16.789341 | localhost | skipping: Conditional result was False 2025-09-06 00:06:16.803121 | 2025-09-06 00:06:16.803364 | LOOP [upload-logs : Upload console log and json output]