2025-09-27 00:00:08.679879 | Job console starting 2025-09-27 00:00:08.702756 | Updating git repos 2025-09-27 00:00:09.436672 | Cloning repos into workspace 2025-09-27 00:00:09.494535 | Restoring repo states 2025-09-27 00:00:09.512610 | Merging changes 2025-09-27 00:00:09.512631 | Checking out repos 2025-09-27 00:00:09.566558 | Preparing playbooks 2025-09-27 00:00:10.060117 | Running Ansible setup 2025-09-27 00:00:14.028540 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-27 00:00:15.409477 | 2025-09-27 00:00:15.409605 | PLAY [Base pre] 2025-09-27 00:00:15.447449 | 2025-09-27 00:00:15.448263 | TASK [Setup log path fact] 2025-09-27 00:00:15.504098 | debian-bookworm | ok 2025-09-27 00:00:15.534368 | 2025-09-27 00:00:15.534508 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-27 00:00:15.595387 | debian-bookworm | ok 2025-09-27 00:00:15.611943 | 2025-09-27 00:00:15.612323 | TASK [emit-job-header : Print job information] 2025-09-27 00:00:15.651124 | # Job Information 2025-09-27 00:00:15.651361 | Ansible Version: 2.16.14 2025-09-27 00:00:15.651399 | Job: container-image-kolla-ansible-push-2025.1 2025-09-27 00:00:15.651433 | Pipeline: periodic-midnight 2025-09-27 00:00:15.651457 | Executor: 521e9411259a 2025-09-27 00:00:15.651478 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-27 00:00:15.651500 | Event ID: 82aceea5fed74a03ab22379253a1a510 2025-09-27 00:00:15.658395 | 2025-09-27 00:00:15.658500 | LOOP [emit-job-header : Print node information] 2025-09-27 00:00:15.858801 | debian-bookworm | ok: 2025-09-27 00:00:15.859039 | debian-bookworm | # Node Information 2025-09-27 00:00:15.859099 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-27 00:00:15.859125 | debian-bookworm | Hostname: debian 2025-09-27 00:00:15.859147 | debian-bookworm | Username: zuul 2025-09-27 00:00:15.859169 | debian-bookworm | Distro: Debian 12.12 2025-09-27 00:00:15.859192 | debian-bookworm | Provider: regiocloud-a 2025-09-27 00:00:15.859213 | debian-bookworm | Region: 2025-09-27 00:00:15.859234 | debian-bookworm | Label: debian-bookworm 2025-09-27 00:00:15.859253 | debian-bookworm | Product Name: OpenStack Nova 2025-09-27 00:00:15.859272 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe1c:90f9 2025-09-27 00:00:15.894255 | 2025-09-27 00:00:15.895721 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-27 00:00:16.832659 | debian-bookworm -> localhost | changed 2025-09-27 00:00:16.840611 | 2025-09-27 00:00:16.840761 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-27 00:00:19.300903 | debian-bookworm -> localhost | changed 2025-09-27 00:00:19.309808 | 2025-09-27 00:00:19.309901 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-27 00:00:19.964688 | debian-bookworm -> localhost | ok 2025-09-27 00:00:19.969615 | 2025-09-27 00:00:19.969707 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-27 00:00:20.006935 | debian-bookworm | ok 2025-09-27 00:00:20.029857 | debian-bookworm | included: /var/lib/zuul/builds/7211b9ceeda74b17a2349972ded9e6f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-27 00:00:20.043130 | 2025-09-27 00:00:20.043216 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-27 00:00:23.379377 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-27 00:00:23.379549 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/7211b9ceeda74b17a2349972ded9e6f4/work/7211b9ceeda74b17a2349972ded9e6f4_id_rsa 2025-09-27 00:00:23.379596 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/7211b9ceeda74b17a2349972ded9e6f4/work/7211b9ceeda74b17a2349972ded9e6f4_id_rsa.pub 2025-09-27 00:00:23.379620 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-27 00:00:23.379639 | debian-bookworm -> localhost | SHA256:2F3qwrMgDzMLjxdssBzAcVI1OOdWfdCvar4gJLYeuwk zuul-build-sshkey 2025-09-27 00:00:23.379666 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-27 00:00:23.379684 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-27 00:00:23.379701 | debian-bookworm -> localhost | |.ooooo ..o | 2025-09-27 00:00:23.379719 | debian-bookworm -> localhost | |..oo ... . o | 2025-09-27 00:00:23.379735 | debian-bookworm -> localhost | | . + . . o | 2025-09-27 00:00:23.379751 | debian-bookworm -> localhost | | o o o . o . | 2025-09-27 00:00:23.379767 | debian-bookworm -> localhost | | . B... S o . | 2025-09-27 00:00:23.379808 | debian-bookworm -> localhost | | + B . . . | 2025-09-27 00:00:23.379830 | debian-bookworm -> localhost | | E.+=o..+ o | 2025-09-27 00:00:23.379847 | debian-bookworm -> localhost | | o+=B...* | 2025-09-27 00:00:23.379864 | debian-bookworm -> localhost | | .*+ . +o. | 2025-09-27 00:00:23.379881 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-27 00:00:23.379924 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.223383 2025-09-27 00:00:23.385136 | 2025-09-27 00:00:23.385213 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-27 00:00:23.423438 | debian-bookworm | ok 2025-09-27 00:00:23.469195 | debian-bookworm | included: /var/lib/zuul/builds/7211b9ceeda74b17a2349972ded9e6f4/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-27 00:00:23.503274 | 2025-09-27 00:00:23.503367 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-27 00:00:23.581816 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:23.587103 | 2025-09-27 00:00:23.587192 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-27 00:00:24.826267 | debian-bookworm | changed 2025-09-27 00:00:24.830605 | 2025-09-27 00:00:24.830682 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-27 00:00:25.091531 | debian-bookworm | ok 2025-09-27 00:00:25.096125 | 2025-09-27 00:00:25.096210 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-27 00:00:25.891925 | debian-bookworm | changed 2025-09-27 00:00:25.897559 | 2025-09-27 00:00:25.897652 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-27 00:00:26.659275 | debian-bookworm | changed 2025-09-27 00:00:26.664295 | 2025-09-27 00:00:26.664368 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-27 00:00:26.709377 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:26.714384 | 2025-09-27 00:00:26.714466 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-27 00:00:27.897754 | debian-bookworm -> localhost | changed 2025-09-27 00:00:27.910855 | 2025-09-27 00:00:27.910948 | TASK [add-build-sshkey : Add back temp key] 2025-09-27 00:00:28.769008 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/7211b9ceeda74b17a2349972ded9e6f4/work/7211b9ceeda74b17a2349972ded9e6f4_id_rsa (zuul-build-sshkey) 2025-09-27 00:00:28.769194 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.051105 2025-09-27 00:00:28.775644 | 2025-09-27 00:00:28.775727 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-27 00:00:29.503201 | debian-bookworm | ok 2025-09-27 00:00:29.508096 | 2025-09-27 00:00:29.508195 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-27 00:00:29.607867 | debian-bookworm | skipping: Conditional result was False 2025-09-27 00:00:29.620421 | 2025-09-27 00:00:29.621055 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-27 00:00:30.141026 | debian-bookworm | ok 2025-09-27 00:00:30.158863 | 2025-09-27 00:00:30.158966 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-27 00:00:30.216003 | debian-bookworm | ok 2025-09-27 00:00:30.220215 | 2025-09-27 00:00:30.220292 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-27 00:00:31.146744 | debian-bookworm -> localhost | ok 2025-09-27 00:00:31.153084 | 2025-09-27 00:00:31.153175 | TASK [validate-host : Collect information about the host] 2025-09-27 00:00:32.628830 | debian-bookworm | ok 2025-09-27 00:00:32.648011 | 2025-09-27 00:00:32.654104 | TASK [validate-host : Sanitize hostname] 2025-09-27 00:00:32.933495 | debian-bookworm | ok 2025-09-27 00:00:33.017859 | 2025-09-27 00:00:33.017966 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-27 00:00:34.327156 | debian-bookworm -> localhost | changed 2025-09-27 00:00:34.331755 | 2025-09-27 00:00:34.331861 | TASK [validate-host : Collect information about zuul worker] 2025-09-27 00:00:34.918041 | debian-bookworm | ok 2025-09-27 00:00:34.921921 | 2025-09-27 00:00:34.921999 | TASK [validate-host : Write out all zuul information for each host] 2025-09-27 00:00:36.002753 | debian-bookworm -> localhost | changed 2025-09-27 00:00:36.011224 | 2025-09-27 00:00:36.011309 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-27 00:00:36.271782 | debian-bookworm | ok 2025-09-27 00:00:36.276647 | 2025-09-27 00:00:36.276727 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-27 00:00:37.805711 | debian-bookworm | changed: 2025-09-27 00:00:37.805879 | debian-bookworm | cd+++++++++ src/ 2025-09-27 00:00:37.805908 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-27 00:00:37.805927 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-27 00:00:37.805944 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-27 00:00:37.805961 | debian-bookworm | Containerfile 2025-09-27 00:00:37.806068 | debian-bookworm | 2025-09-27 00:08:59.642614 | debian-bookworm | ERROR 2025-09-27 00:08:59.643167 | debian-bookworm | { 2025-09-27 00:08:59.643288 | debian-bookworm | "delta": "0:00:21.568789", 2025-09-27 00:08:59.643358 | debian-bookworm | "end": "2025-09-27 00:08:59.450424", 2025-09-27 00:08:59.643431 | debian-bookworm | "msg": "non-zero return code", 2025-09-27 00:08:59.643490 | debian-bookworm | "rc": 1, 2025-09-27 00:08:59.643545 | debian-bookworm | "start": "2025-09-27 00:08:37.881635" 2025-09-27 00:08:59.643598 | debian-bookworm | } failure 2025-09-27 00:08:59.648844 | 2025-09-27 00:08:59.649049 | PLAY RECAP 2025-09-27 00:08:59.649186 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-27 00:08:59.649258 | 2025-09-27 00:08:59.756878 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-27 00:08:59.758438 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-27 00:09:00.438026 | 2025-09-27 00:09:00.438146 | PLAY [Base post] 2025-09-27 00:09:00.450198 | 2025-09-27 00:09:00.450298 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-27 00:09:01.248588 | debian-bookworm | changed 2025-09-27 00:09:01.254617 | 2025-09-27 00:09:01.254696 | PLAY RECAP 2025-09-27 00:09:01.254787 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-27 00:09:01.254919 | 2025-09-27 00:09:01.336992 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-27 00:09:01.339424 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-27 00:09:02.072756 | 2025-09-27 00:09:02.072910 | PLAY [Base post-logs] 2025-09-27 00:09:02.083025 | 2025-09-27 00:09:02.083132 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-27 00:09:02.524302 | localhost | changed 2025-09-27 00:09:02.533777 | 2025-09-27 00:09:02.533918 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-27 00:09:02.568927 | localhost | ok 2025-09-27 00:09:02.572682 | 2025-09-27 00:09:02.572784 | TASK [Set zuul-log-path fact] 2025-09-27 00:09:02.588156 | localhost | ok 2025-09-27 00:09:02.601002 | 2025-09-27 00:09:02.601150 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-27 00:09:02.639189 | localhost | ok 2025-09-27 00:09:02.647934 | 2025-09-27 00:09:02.648152 | TASK [upload-logs : Create log directories] 2025-09-27 00:09:03.095311 | localhost | changed 2025-09-27 00:09:03.099723 | 2025-09-27 00:09:03.099934 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-27 00:09:03.582518 | localhost -> localhost | ok: Runtime: 0:00:00.007333 2025-09-27 00:09:03.590495 | 2025-09-27 00:09:03.590669 | TASK [upload-logs : Upload logs to log server] 2025-09-27 00:09:04.136793 | localhost | Output suppressed because no_log was given 2025-09-27 00:09:04.140103 | 2025-09-27 00:09:04.143692 | LOOP [upload-logs : Compress console log and json output] 2025-09-27 00:09:04.194368 | localhost | skipping: Conditional result was False 2025-09-27 00:09:04.201502 | localhost | skipping: Conditional result was False 2025-09-27 00:09:04.212231 | 2025-09-27 00:09:04.212441 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-27 00:09:04.251422 | localhost | skipping: Conditional result was False 2025-09-27 00:09:04.251674 | 2025-09-27 00:09:04.257740 | localhost | skipping: Conditional result was False 2025-09-27 00:09:04.274645 | 2025-09-27 00:09:04.274926 | LOOP [upload-logs : Upload console log and json output]