2025-09-21 00:00:04.449738 | Job console starting 2025-09-21 00:00:04.477792 | Updating git repos 2025-09-21 00:00:04.523164 | Cloning repos into workspace 2025-09-21 00:00:04.603677 | Restoring repo states 2025-09-21 00:00:04.614650 | Merging changes 2025-09-21 00:00:04.614671 | Checking out repos 2025-09-21 00:00:04.689054 | Preparing playbooks 2025-09-21 00:00:05.391078 | Running Ansible setup 2025-09-21 00:00:10.073617 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-21 00:00:11.482051 | 2025-09-21 00:00:11.482178 | PLAY [Base pre] 2025-09-21 00:00:11.509297 | 2025-09-21 00:00:11.509440 | TASK [Setup log path fact] 2025-09-21 00:00:11.538031 | debian-bookworm | ok 2025-09-21 00:00:11.580979 | 2025-09-21 00:00:11.581116 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-21 00:00:11.630231 | debian-bookworm | ok 2025-09-21 00:00:11.653114 | 2025-09-21 00:00:11.653228 | TASK [emit-job-header : Print job information] 2025-09-21 00:00:11.743202 | # Job Information 2025-09-21 00:00:11.743477 | Ansible Version: 2.16.14 2025-09-21 00:00:11.743524 | Job: container-image-kolla-ansible-push-2024.1 2025-09-21 00:00:11.743559 | Pipeline: periodic-midnight 2025-09-21 00:00:11.743583 | Executor: 521e9411259a 2025-09-21 00:00:11.743604 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-21 00:00:11.743628 | Event ID: 7a0ab0086b814e9c86a5b9aac3cc9946 2025-09-21 00:00:11.750771 | 2025-09-21 00:00:11.750913 | LOOP [emit-job-header : Print node information] 2025-09-21 00:00:12.106049 | debian-bookworm | ok: 2025-09-21 00:00:12.106276 | debian-bookworm | # Node Information 2025-09-21 00:00:12.106326 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-21 00:00:12.106353 | debian-bookworm | Hostname: debian 2025-09-21 00:00:12.106376 | debian-bookworm | Username: zuul 2025-09-21 00:00:12.106397 | debian-bookworm | Distro: Debian 12.12 2025-09-21 00:00:12.106421 | debian-bookworm | Provider: regiocloud-a 2025-09-21 00:00:12.106442 | debian-bookworm | Region: 2025-09-21 00:00:12.106464 | debian-bookworm | Label: debian-bookworm 2025-09-21 00:00:12.106484 | debian-bookworm | Product Name: OpenStack Nova 2025-09-21 00:00:12.106504 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe25:9b79 2025-09-21 00:00:12.119128 | 2025-09-21 00:00:12.119271 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-21 00:00:13.180814 | debian-bookworm -> localhost | changed 2025-09-21 00:00:13.210121 | 2025-09-21 00:00:13.210240 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-21 00:00:14.912242 | debian-bookworm -> localhost | changed 2025-09-21 00:00:14.924987 | 2025-09-21 00:00:14.925096 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-21 00:00:15.582638 | debian-bookworm -> localhost | ok 2025-09-21 00:00:15.589123 | 2025-09-21 00:00:15.589225 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-21 00:00:15.608161 | debian-bookworm | ok 2025-09-21 00:00:15.648875 | debian-bookworm | included: /var/lib/zuul/builds/86e2cd26d85d4fda83c246ea6683fa3f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-21 00:00:15.661340 | 2025-09-21 00:00:15.661443 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-21 00:00:18.890325 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-21 00:00:18.890498 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/86e2cd26d85d4fda83c246ea6683fa3f/work/86e2cd26d85d4fda83c246ea6683fa3f_id_rsa 2025-09-21 00:00:18.890529 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/86e2cd26d85d4fda83c246ea6683fa3f/work/86e2cd26d85d4fda83c246ea6683fa3f_id_rsa.pub 2025-09-21 00:00:18.890551 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-21 00:00:18.890570 | debian-bookworm -> localhost | SHA256:rzWQ+BsOFJX+/NGL6Oq6nDhKLN45nrusc+kKR5T3AAA zuul-build-sshkey 2025-09-21 00:00:18.890597 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-21 00:00:18.890616 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-21 00:00:18.890634 | debian-bookworm -> localhost | |E.. .. | 2025-09-21 00:00:18.890653 | debian-bookworm -> localhost | | o .. | 2025-09-21 00:00:18.890669 | debian-bookworm -> localhost | | o o .. | 2025-09-21 00:00:18.890685 | debian-bookworm -> localhost | | . . o o.. | 2025-09-21 00:00:18.890701 | debian-bookworm -> localhost | | . + So . | 2025-09-21 00:00:18.890721 | debian-bookworm -> localhost | | o . . oo . . | 2025-09-21 00:00:18.890738 | debian-bookworm -> localhost | |o + . . o +o o . | 2025-09-21 00:00:18.890755 | debian-bookworm -> localhost | |o=o++o + =..o . | 2025-09-21 00:00:18.890772 | debian-bookworm -> localhost | | +O@=.=+*o. | 2025-09-21 00:00:18.890788 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-21 00:00:18.890898 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.951753 2025-09-21 00:00:18.895992 | 2025-09-21 00:00:18.896072 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-21 00:00:18.922655 | debian-bookworm | ok 2025-09-21 00:00:18.944924 | debian-bookworm | included: /var/lib/zuul/builds/86e2cd26d85d4fda83c246ea6683fa3f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-21 00:00:18.977621 | 2025-09-21 00:00:18.977716 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-21 00:00:19.030736 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:00:19.035583 | 2025-09-21 00:00:19.035668 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-21 00:00:19.813255 | debian-bookworm | changed 2025-09-21 00:00:19.817620 | 2025-09-21 00:00:19.817691 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-21 00:00:20.083147 | debian-bookworm | ok 2025-09-21 00:00:20.087696 | 2025-09-21 00:00:20.087782 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-21 00:00:20.782748 | debian-bookworm | changed 2025-09-21 00:00:20.796454 | 2025-09-21 00:00:20.796542 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-21 00:00:21.590037 | debian-bookworm | changed 2025-09-21 00:00:21.596461 | 2025-09-21 00:00:21.596556 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-21 00:00:21.639610 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:00:21.645421 | 2025-09-21 00:00:21.645521 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-21 00:00:23.070382 | debian-bookworm -> localhost | changed 2025-09-21 00:00:23.081834 | 2025-09-21 00:00:23.081935 | TASK [add-build-sshkey : Add back temp key] 2025-09-21 00:00:23.900580 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/86e2cd26d85d4fda83c246ea6683fa3f/work/86e2cd26d85d4fda83c246ea6683fa3f_id_rsa (zuul-build-sshkey) 2025-09-21 00:00:23.900767 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.025769 2025-09-21 00:00:23.909004 | 2025-09-21 00:00:23.909105 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-21 00:00:24.448258 | debian-bookworm | ok 2025-09-21 00:00:24.452530 | 2025-09-21 00:00:24.452607 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-21 00:00:24.485980 | debian-bookworm | skipping: Conditional result was False 2025-09-21 00:00:24.500893 | 2025-09-21 00:00:24.500983 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-21 00:00:25.184440 | debian-bookworm | ok 2025-09-21 00:00:25.203988 | 2025-09-21 00:00:25.204084 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-21 00:00:25.240645 | debian-bookworm | ok 2025-09-21 00:00:25.244658 | 2025-09-21 00:00:25.244728 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-21 00:00:26.069291 | debian-bookworm -> localhost | ok 2025-09-21 00:00:26.074355 | 2025-09-21 00:00:26.074446 | TASK [validate-host : Collect information about the host] 2025-09-21 00:00:27.521970 | debian-bookworm | ok 2025-09-21 00:00:27.538952 | 2025-09-21 00:00:27.539046 | TASK [validate-host : Sanitize hostname] 2025-09-21 00:00:27.714077 | debian-bookworm | ok 2025-09-21 00:00:27.745896 | 2025-09-21 00:00:27.745985 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-21 00:00:29.023975 | debian-bookworm -> localhost | changed 2025-09-21 00:00:29.028625 | 2025-09-21 00:00:29.028705 | TASK [validate-host : Collect information about zuul worker] 2025-09-21 00:00:29.589785 | debian-bookworm | ok 2025-09-21 00:00:29.593663 | 2025-09-21 00:00:29.593746 | TASK [validate-host : Write out all zuul information for each host] 2025-09-21 00:00:30.761693 | debian-bookworm -> localhost | changed 2025-09-21 00:00:30.769147 | 2025-09-21 00:00:30.769228 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-21 00:00:31.058969 | debian-bookworm | ok 2025-09-21 00:00:31.074407 | 2025-09-21 00:00:31.074500 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-21 00:00:32.593729 | debian-bookworm | changed: 2025-09-21 00:00:32.593886 | debian-bookworm | cd+++++++++ src/ 2025-09-21 00:00:32.593916 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-21 00:00:32.593937 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-21 00:00:32.593956 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-21 00:00:32.593973 | debian-bookworm | Containerfile 2025-09-21 00:00:32.594085 | debian-bookworm | 2025-09-21 00:07:59.719917 | debian-bookworm | ERROR 2025-09-21 00:07:59.720357 | debian-bookworm | { 2025-09-21 00:07:59.720461 | debian-bookworm | "delta": "0:00:19.774219", 2025-09-21 00:07:59.720617 | debian-bookworm | "end": "2025-09-21 00:07:59.291152", 2025-09-21 00:07:59.720709 | debian-bookworm | "msg": "non-zero return code", 2025-09-21 00:07:59.720766 | debian-bookworm | "rc": 1, 2025-09-21 00:07:59.720815 | debian-bookworm | "start": "2025-09-21 00:07:39.516933" 2025-09-21 00:07:59.720861 | debian-bookworm | } failure 2025-09-21 00:07:59.724176 | 2025-09-21 00:07:59.724324 | PLAY RECAP 2025-09-21 00:07:59.724446 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-21 00:07:59.724509 | 2025-09-21 00:07:59.822730 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-21 00:07:59.824011 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-21 00:08:00.491175 | 2025-09-21 00:08:00.491339 | PLAY [Base post] 2025-09-21 00:08:00.503344 | 2025-09-21 00:08:00.503450 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-21 00:08:01.375278 | debian-bookworm | changed 2025-09-21 00:08:01.381755 | 2025-09-21 00:08:01.381859 | PLAY RECAP 2025-09-21 00:08:01.381919 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-21 00:08:01.381982 | 2025-09-21 00:08:01.485494 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-21 00:08:01.486412 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-21 00:08:02.182369 | 2025-09-21 00:08:02.182498 | PLAY [Base post-logs] 2025-09-21 00:08:02.192991 | 2025-09-21 00:08:02.193127 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-21 00:08:02.714984 | localhost | changed 2025-09-21 00:08:02.724818 | 2025-09-21 00:08:02.724930 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-21 00:08:02.764755 | localhost | ok 2025-09-21 00:08:02.774560 | 2025-09-21 00:08:02.774956 | TASK [Set zuul-log-path fact] 2025-09-21 00:08:02.803029 | localhost | ok 2025-09-21 00:08:02.814736 | 2025-09-21 00:08:02.814899 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-21 00:08:02.851465 | localhost | ok 2025-09-21 00:08:02.856660 | 2025-09-21 00:08:02.856797 | TASK [upload-logs : Create log directories] 2025-09-21 00:08:03.306456 | localhost | changed 2025-09-21 00:08:03.311245 | 2025-09-21 00:08:03.311381 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-21 00:08:03.740273 | localhost -> localhost | ok: Runtime: 0:00:00.006093 2025-09-21 00:08:03.743897 | 2025-09-21 00:08:03.743987 | TASK [upload-logs : Upload logs to log server] 2025-09-21 00:08:04.247761 | localhost | Output suppressed because no_log was given 2025-09-21 00:08:04.252788 | 2025-09-21 00:08:04.252993 | LOOP [upload-logs : Compress console log and json output] 2025-09-21 00:08:04.303627 | localhost | skipping: Conditional result was False 2025-09-21 00:08:04.308034 | localhost | skipping: Conditional result was False 2025-09-21 00:08:04.315259 | 2025-09-21 00:08:04.315475 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-21 00:08:04.363652 | localhost | skipping: Conditional result was False 2025-09-21 00:08:04.364241 | 2025-09-21 00:08:04.367266 | localhost | skipping: Conditional result was False 2025-09-21 00:08:04.382085 | 2025-09-21 00:08:04.382257 | LOOP [upload-logs : Upload console log and json output]