2025-10-03 07:32:39.244613 | Job console starting 2025-10-03 07:32:39.253939 | Updating git repos 2025-10-03 07:32:39.297432 | Cloning repos into workspace 2025-10-03 07:32:39.391796 | Restoring repo states 2025-10-03 07:32:39.419207 | Merging changes 2025-10-03 07:32:39.419219 | Checking out repos 2025-10-03 07:32:39.611052 | Preparing playbooks 2025-10-03 07:32:40.885172 | Running Ansible setup 2025-10-03 07:32:47.752536 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-03 07:32:48.812967 | 2025-10-03 07:32:48.813104 | PLAY [Base pre] 2025-10-03 07:32:48.841800 | 2025-10-03 07:32:48.841900 | TASK [Setup log path fact] 2025-10-03 07:32:48.878856 | debian-bookworm | ok 2025-10-03 07:32:48.904640 | 2025-10-03 07:32:48.904753 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:32:48.981046 | debian-bookworm | ok 2025-10-03 07:32:48.990551 | 2025-10-03 07:32:48.990657 | TASK [emit-job-header : Print job information] 2025-10-03 07:32:49.065694 | # Job Information 2025-10-03 07:32:49.065839 | Ansible Version: 2.16.14 2025-10-03 07:32:49.065867 | Job: container-image-kolla-ansible-push-2024.1 2025-10-03 07:32:49.065895 | Pipeline: post 2025-10-03 07:32:49.065913 | Executor: 521e9411259a 2025-10-03 07:32:49.065930 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/2459e269da2cd73ba72704b2bf25c9b90cac09c8 2025-10-03 07:32:49.065952 | Event ID: 2111bd7a-a02b-11f0-95c0-d288294c356d 2025-10-03 07:32:49.070016 | 2025-10-03 07:32:49.070124 | LOOP [emit-job-header : Print node information] 2025-10-03 07:32:49.282310 | debian-bookworm | ok: 2025-10-03 07:32:49.282447 | debian-bookworm | # Node Information 2025-10-03 07:32:49.282474 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-03 07:32:49.282495 | debian-bookworm | Hostname: debian 2025-10-03 07:32:49.282513 | debian-bookworm | Username: zuul 2025-10-03 07:32:49.282530 | debian-bookworm | Distro: Debian 12.12 2025-10-03 07:32:49.282550 | debian-bookworm | Provider: regiocloud-a 2025-10-03 07:32:49.282567 | debian-bookworm | Region: 2025-10-03 07:32:49.282585 | debian-bookworm | Label: debian-bookworm 2025-10-03 07:32:49.282601 | debian-bookworm | Product Name: OpenStack Nova 2025-10-03 07:32:49.282617 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe43:47d0 2025-10-03 07:32:49.295131 | 2025-10-03 07:32:49.295225 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-03 07:32:50.385074 | debian-bookworm -> localhost | changed 2025-10-03 07:32:50.390746 | 2025-10-03 07:32:50.390825 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-03 07:32:51.912110 | debian-bookworm -> localhost | changed 2025-10-03 07:32:51.921153 | 2025-10-03 07:32:51.921242 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-03 07:32:52.167408 | debian-bookworm -> localhost | ok 2025-10-03 07:32:52.181270 | 2025-10-03 07:32:52.181394 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-03 07:32:52.209789 | debian-bookworm | ok 2025-10-03 07:32:52.226894 | debian-bookworm | included: /var/lib/zuul/builds/b16b955afa6646109d9faac47cb8bfbd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-03 07:32:52.232835 | 2025-10-03 07:32:52.232924 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-03 07:32:53.588924 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-03 07:32:53.589133 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/b16b955afa6646109d9faac47cb8bfbd/work/b16b955afa6646109d9faac47cb8bfbd_id_rsa 2025-10-03 07:32:53.589174 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/b16b955afa6646109d9faac47cb8bfbd/work/b16b955afa6646109d9faac47cb8bfbd_id_rsa.pub 2025-10-03 07:32:53.589203 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-03 07:32:53.589228 | debian-bookworm -> localhost | SHA256:VFhbcKDdrXcOHQypRlD/ebSqd8AMcSr71WsxIBrFQ3Y zuul-build-sshkey 2025-10-03 07:32:53.589261 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-03 07:32:53.589284 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-03 07:32:53.589306 | debian-bookworm -> localhost | | +X*oE. | 2025-10-03 07:32:53.589328 | debian-bookworm -> localhost | | .+.@o+o | 2025-10-03 07:32:53.589349 | debian-bookworm -> localhost | | o = B..o.| 2025-10-03 07:32:53.589369 | debian-bookworm -> localhost | | . o * o.o+| 2025-10-03 07:32:53.589389 | debian-bookworm -> localhost | | S * * =++| 2025-10-03 07:32:53.589413 | debian-bookworm -> localhost | | o *.B.| 2025-10-03 07:32:53.589434 | debian-bookworm -> localhost | | . ... =| 2025-10-03 07:32:53.589454 | debian-bookworm -> localhost | | ... + | 2025-10-03 07:32:53.589475 | debian-bookworm -> localhost | | .. o | 2025-10-03 07:32:53.589496 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-03 07:32:53.589547 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.941987 2025-10-03 07:32:53.595630 | 2025-10-03 07:32:53.595710 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-03 07:32:53.623323 | debian-bookworm | ok 2025-10-03 07:32:53.631890 | debian-bookworm | included: /var/lib/zuul/builds/b16b955afa6646109d9faac47cb8bfbd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-03 07:32:53.639140 | 2025-10-03 07:32:53.639203 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-03 07:32:53.662282 | debian-bookworm | skipping: Conditional result was False 2025-10-03 07:32:53.670496 | 2025-10-03 07:32:53.670601 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-03 07:32:54.233533 | debian-bookworm | changed 2025-10-03 07:32:54.238748 | 2025-10-03 07:32:54.238845 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-03 07:32:54.491930 | debian-bookworm | ok 2025-10-03 07:32:54.500078 | 2025-10-03 07:32:54.500187 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-03 07:32:55.149525 | debian-bookworm | changed 2025-10-03 07:32:55.159163 | 2025-10-03 07:32:55.159344 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-03 07:32:55.783300 | debian-bookworm | changed 2025-10-03 07:32:55.788475 | 2025-10-03 07:32:55.788559 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-03 07:32:55.814133 | debian-bookworm | skipping: Conditional result was False 2025-10-03 07:32:55.825837 | 2025-10-03 07:32:55.825947 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-03 07:32:56.206891 | debian-bookworm -> localhost | changed 2025-10-03 07:32:56.233768 | 2025-10-03 07:32:56.233866 | TASK [add-build-sshkey : Add back temp key] 2025-10-03 07:32:56.545319 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/b16b955afa6646109d9faac47cb8bfbd/work/b16b955afa6646109d9faac47cb8bfbd_id_rsa (zuul-build-sshkey) 2025-10-03 07:32:56.545529 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.016374 2025-10-03 07:32:56.554954 | 2025-10-03 07:32:56.555070 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-03 07:32:56.941444 | debian-bookworm | ok 2025-10-03 07:32:56.947216 | 2025-10-03 07:32:56.947306 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-03 07:32:56.970528 | debian-bookworm | skipping: Conditional result was False 2025-10-03 07:32:56.980284 | 2025-10-03 07:32:56.980370 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-03 07:32:57.402551 | debian-bookworm | ok 2025-10-03 07:32:57.416644 | 2025-10-03 07:32:57.416753 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-03 07:32:57.461524 | debian-bookworm | ok 2025-10-03 07:32:57.469335 | 2025-10-03 07:32:57.469457 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-03 07:32:57.726814 | debian-bookworm -> localhost | ok 2025-10-03 07:32:57.732970 | 2025-10-03 07:32:57.733065 | TASK [validate-host : Collect information about the host] 2025-10-03 07:32:58.808397 | debian-bookworm | ok 2025-10-03 07:32:58.819848 | 2025-10-03 07:32:58.819933 | TASK [validate-host : Sanitize hostname] 2025-10-03 07:32:58.904978 | debian-bookworm | ok 2025-10-03 07:32:58.935620 | 2025-10-03 07:32:58.935714 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-03 07:32:59.408149 | debian-bookworm -> localhost | changed 2025-10-03 07:32:59.414279 | 2025-10-03 07:32:59.414376 | TASK [validate-host : Collect information about zuul worker] 2025-10-03 07:32:59.825307 | debian-bookworm | ok 2025-10-03 07:32:59.832493 | 2025-10-03 07:32:59.832621 | TASK [validate-host : Write out all zuul information for each host] 2025-10-03 07:33:00.376895 | debian-bookworm -> localhost | changed 2025-10-03 07:33:00.396215 | 2025-10-03 07:33:00.396351 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-03 07:33:00.679332 | debian-bookworm | ok 2025-10-03 07:33:00.686509 | 2025-10-03 07:33:00.686649 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-03 07:33:01.787684 | debian-bookworm | changed: 2025-10-03 07:33:01.787965 | debian-bookworm | cd+++++++++ src/ 2025-10-03 07:33:01.788025 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-03 07:33:01.788096 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-03 07:33:01.788120 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-10-03 07:33:01.788142 | debian-bookworm | Containerfile 2025-10-03 07:33:01.788275 | debian-bookworm | 2025-10-03 07:45:57.509812 | debian-bookworm | ERROR 2025-10-03 07:45:57.510250 | debian-bookworm | { 2025-10-03 07:45:57.510358 | debian-bookworm | "delta": "0:00:20.868622", 2025-10-03 07:45:57.510431 | debian-bookworm | "end": "2025-10-03 07:45:57.122396", 2025-10-03 07:45:57.510505 | debian-bookworm | "msg": "non-zero return code", 2025-10-03 07:45:57.510593 | debian-bookworm | "rc": 1, 2025-10-03 07:45:57.510648 | debian-bookworm | "start": "2025-10-03 07:45:36.253774" 2025-10-03 07:45:57.510702 | debian-bookworm | } failure 2025-10-03 07:45:57.514567 | 2025-10-03 07:45:57.514714 | PLAY RECAP 2025-10-03 07:45:57.514882 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:45:57.514973 | 2025-10-03 07:45:57.636974 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-10-03 07:45:57.639613 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-03 07:45:58.403726 | 2025-10-03 07:45:58.403907 | PLAY [Base post] 2025-10-03 07:45:58.417613 | 2025-10-03 07:45:58.417742 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-03 07:45:59.277449 | debian-bookworm | changed 2025-10-03 07:45:59.286561 | 2025-10-03 07:45:59.286687 | PLAY RECAP 2025-10-03 07:45:59.286771 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-03 07:45:59.286873 | 2025-10-03 07:45:59.400780 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-03 07:45:59.403288 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-03 07:46:00.175357 | 2025-10-03 07:46:00.175513 | PLAY [Base post-logs] 2025-10-03 07:46:00.194825 | 2025-10-03 07:46:00.195143 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-03 07:46:00.676055 | localhost | changed 2025-10-03 07:46:00.691414 | 2025-10-03 07:46:00.691656 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-03 07:46:00.728441 | localhost | ok 2025-10-03 07:46:00.733788 | 2025-10-03 07:46:00.733928 | TASK [Set zuul-log-path fact] 2025-10-03 07:46:00.760774 | localhost | ok 2025-10-03 07:46:00.771357 | 2025-10-03 07:46:00.771467 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-03 07:46:00.807030 | localhost | ok 2025-10-03 07:46:00.812117 | 2025-10-03 07:46:00.812257 | TASK [upload-logs : Create log directories] 2025-10-03 07:46:01.307897 | localhost | changed 2025-10-03 07:46:01.310729 | 2025-10-03 07:46:01.310849 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-03 07:46:01.790385 | localhost -> localhost | ok: Runtime: 0:00:00.005734 2025-10-03 07:46:01.796166 | 2025-10-03 07:46:01.796296 | TASK [upload-logs : Upload logs to log server] 2025-10-03 07:46:02.330712 | localhost | Output suppressed because no_log was given 2025-10-03 07:46:02.332879 | 2025-10-03 07:46:02.333004 | LOOP [upload-logs : Compress console log and json output] 2025-10-03 07:46:02.384032 | localhost | skipping: Conditional result was False 2025-10-03 07:46:02.389000 | localhost | skipping: Conditional result was False 2025-10-03 07:46:02.403694 | 2025-10-03 07:46:02.403917 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-03 07:46:02.449718 | localhost | skipping: Conditional result was False 2025-10-03 07:46:02.450455 | 2025-10-03 07:46:02.453710 | localhost | skipping: Conditional result was False 2025-10-03 07:46:02.467559 | 2025-10-03 07:46:02.467801 | LOOP [upload-logs : Upload console log and json output]