2025-09-29 07:18:13.786632 | Job console starting 2025-09-29 07:18:13.810305 | Updating git repos 2025-09-29 07:18:13.876414 | Cloning repos into workspace 2025-09-29 07:18:13.926904 | Restoring repo states 2025-09-29 07:18:13.942612 | Merging changes 2025-09-29 07:18:13.942629 | Checking out repos 2025-09-29 07:18:14.013076 | Preparing playbooks 2025-09-29 07:18:14.809448 | Running Ansible setup 2025-09-29 07:18:18.930230 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-29 07:18:19.691391 | 2025-09-29 07:18:19.691545 | PLAY [Base pre] 2025-09-29 07:18:19.717898 | 2025-09-29 07:18:19.718121 | TASK [Setup log path fact] 2025-09-29 07:18:19.748990 | debian-bookworm | ok 2025-09-29 07:18:19.774529 | 2025-09-29 07:18:19.774666 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-29 07:18:19.803782 | debian-bookworm | ok 2025-09-29 07:18:19.813537 | 2025-09-29 07:18:19.813649 | TASK [emit-job-header : Print job information] 2025-09-29 07:18:19.851768 | # Job Information 2025-09-29 07:18:19.851950 | Ansible Version: 2.16.14 2025-09-29 07:18:19.851986 | Job: container-image-kolla-ansible-push-2024.2 2025-09-29 07:18:19.852020 | Pipeline: post 2025-09-29 07:18:19.852043 | Executor: 521e9411259a 2025-09-29 07:18:19.852083 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/7854f6d9900abebd7a7839cff930dcbea322749a 2025-09-29 07:18:19.852106 | Event ID: 709d51e4-9d04-11f0-9c89-f77c72873729 2025-09-29 07:18:19.857164 | 2025-09-29 07:18:19.857268 | LOOP [emit-job-header : Print node information] 2025-09-29 07:18:19.976192 | debian-bookworm | ok: 2025-09-29 07:18:19.976430 | debian-bookworm | # Node Information 2025-09-29 07:18:19.976468 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-29 07:18:19.976495 | debian-bookworm | Hostname: debian 2025-09-29 07:18:19.976517 | debian-bookworm | Username: zuul 2025-09-29 07:18:19.976538 | debian-bookworm | Distro: Debian 12.12 2025-09-29 07:18:19.976562 | debian-bookworm | Provider: regiocloud-a 2025-09-29 07:18:19.976583 | debian-bookworm | Region: 2025-09-29 07:18:19.976604 | debian-bookworm | Label: debian-bookworm 2025-09-29 07:18:19.976624 | debian-bookworm | Product Name: OpenStack Nova 2025-09-29 07:18:19.976643 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe45:f8a1 2025-09-29 07:18:19.997347 | 2025-09-29 07:18:19.997487 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-29 07:18:20.476250 | debian-bookworm -> localhost | changed 2025-09-29 07:18:20.489231 | 2025-09-29 07:18:20.489407 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-29 07:18:21.501879 | debian-bookworm -> localhost | changed 2025-09-29 07:18:21.513758 | 2025-09-29 07:18:21.513877 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-29 07:18:21.787468 | debian-bookworm -> localhost | ok 2025-09-29 07:18:21.793937 | 2025-09-29 07:18:21.794103 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-29 07:18:21.812313 | debian-bookworm | ok 2025-09-29 07:18:21.829783 | debian-bookworm | included: /var/lib/zuul/builds/491c22d3ba05498faf0bb1d5df580269/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-29 07:18:21.835913 | 2025-09-29 07:18:21.836010 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-29 07:18:23.068856 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-29 07:18:23.069117 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/491c22d3ba05498faf0bb1d5df580269/work/491c22d3ba05498faf0bb1d5df580269_id_rsa 2025-09-29 07:18:23.069160 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/491c22d3ba05498faf0bb1d5df580269/work/491c22d3ba05498faf0bb1d5df580269_id_rsa.pub 2025-09-29 07:18:23.069186 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-29 07:18:23.069210 | debian-bookworm -> localhost | SHA256:aKri5/3TqAjyry0h7EH24yxuGbspP8QRZdHilR5fDng zuul-build-sshkey 2025-09-29 07:18:23.069246 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-29 07:18:23.069269 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-29 07:18:23.069291 | debian-bookworm -> localhost | | .+o o | 2025-09-29 07:18:23.069313 | debian-bookworm -> localhost | | ... * E . | 2025-09-29 07:18:23.069333 | debian-bookworm -> localhost | | o + + + | 2025-09-29 07:18:23.069353 | debian-bookworm -> localhost | | o. . ... . | 2025-09-29 07:18:23.069373 | debian-bookworm -> localhost | |+... o S | 2025-09-29 07:18:23.069400 | debian-bookworm -> localhost | |.++o o | 2025-09-29 07:18:23.069421 | debian-bookworm -> localhost | |o+B.o o | 2025-09-29 07:18:23.069441 | debian-bookworm -> localhost | |+B=*o o . | 2025-09-29 07:18:23.069462 | debian-bookworm -> localhost | |=BXBooo.. | 2025-09-29 07:18:23.069483 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-29 07:18:23.069539 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.762054 2025-09-29 07:18:23.076042 | 2025-09-29 07:18:23.076185 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-29 07:18:23.104512 | debian-bookworm | ok 2025-09-29 07:18:23.113765 | debian-bookworm | included: /var/lib/zuul/builds/491c22d3ba05498faf0bb1d5df580269/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-29 07:18:23.122689 | 2025-09-29 07:18:23.122783 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-29 07:18:23.145843 | debian-bookworm | skipping: Conditional result was False 2025-09-29 07:18:23.151789 | 2025-09-29 07:18:23.151888 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-29 07:18:23.801242 | debian-bookworm | changed 2025-09-29 07:18:23.807382 | 2025-09-29 07:18:23.807491 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-29 07:18:24.070479 | debian-bookworm | ok 2025-09-29 07:18:24.078577 | 2025-09-29 07:18:24.078703 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-29 07:18:24.766875 | debian-bookworm | changed 2025-09-29 07:18:24.780046 | 2025-09-29 07:18:24.780192 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-29 07:18:25.435375 | debian-bookworm | changed 2025-09-29 07:18:25.444371 | 2025-09-29 07:18:25.444507 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-29 07:18:25.468542 | debian-bookworm | skipping: Conditional result was False 2025-09-29 07:18:25.474550 | 2025-09-29 07:18:25.474661 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-29 07:18:25.909146 | debian-bookworm -> localhost | changed 2025-09-29 07:18:25.920172 | 2025-09-29 07:18:25.920286 | TASK [add-build-sshkey : Add back temp key] 2025-09-29 07:18:26.259821 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/491c22d3ba05498faf0bb1d5df580269/work/491c22d3ba05498faf0bb1d5df580269_id_rsa (zuul-build-sshkey) 2025-09-29 07:18:26.260190 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018054 2025-09-29 07:18:26.273359 | 2025-09-29 07:18:26.273509 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-29 07:18:26.683324 | debian-bookworm | ok 2025-09-29 07:18:26.690438 | 2025-09-29 07:18:26.690555 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-29 07:18:26.714915 | debian-bookworm | skipping: Conditional result was False 2025-09-29 07:18:26.725657 | 2025-09-29 07:18:26.725778 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-29 07:18:27.142635 | debian-bookworm | ok 2025-09-29 07:18:27.154177 | 2025-09-29 07:18:27.154291 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-29 07:18:27.182891 | debian-bookworm | ok 2025-09-29 07:18:27.188368 | 2025-09-29 07:18:27.188475 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-29 07:18:27.476961 | debian-bookworm -> localhost | ok 2025-09-29 07:18:27.483685 | 2025-09-29 07:18:27.483796 | TASK [validate-host : Collect information about the host] 2025-09-29 07:18:28.636020 | debian-bookworm | ok 2025-09-29 07:18:28.646779 | 2025-09-29 07:18:28.646916 | TASK [validate-host : Sanitize hostname] 2025-09-29 07:18:28.761582 | debian-bookworm | ok 2025-09-29 07:18:28.828895 | 2025-09-29 07:18:28.829039 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-29 07:18:29.449272 | debian-bookworm -> localhost | changed 2025-09-29 07:18:29.455565 | 2025-09-29 07:18:29.455681 | TASK [validate-host : Collect information about zuul worker] 2025-09-29 07:18:29.914492 | debian-bookworm | ok 2025-09-29 07:18:29.919329 | 2025-09-29 07:18:29.919448 | TASK [validate-host : Write out all zuul information for each host] 2025-09-29 07:18:30.458544 | debian-bookworm -> localhost | changed 2025-09-29 07:18:30.468790 | 2025-09-29 07:18:30.468906 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-29 07:18:30.743897 | debian-bookworm | ok 2025-09-29 07:18:30.750381 | 2025-09-29 07:18:30.750489 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-29 07:18:31.634422 | debian-bookworm | changed: 2025-09-29 07:18:31.634694 | debian-bookworm | cd+++++++++ src/ 2025-09-29 07:18:31.634745 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-29 07:18:31.634782 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-29 07:18:31.634812 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-29 07:18:31.634881 | debian-bookworm | Containerfile 2025-09-29 07:18:31.635103 | debian-bookworm | 2025-09-29 07:29:37.398312 | debian-bookworm | ERROR 2025-09-29 07:29:37.398784 | debian-bookworm | { 2025-09-29 07:29:37.398931 | debian-bookworm | "delta": "0:00:20.138233", 2025-09-29 07:29:37.399004 | debian-bookworm | "end": "2025-09-29 07:29:37.270020", 2025-09-29 07:29:37.399078 | debian-bookworm | "msg": "non-zero return code", 2025-09-29 07:29:37.399162 | debian-bookworm | "rc": 1, 2025-09-29 07:29:37.399219 | debian-bookworm | "start": "2025-09-29 07:29:17.131787" 2025-09-29 07:29:37.399273 | debian-bookworm | } failure 2025-09-29 07:29:37.403901 | 2025-09-29 07:29:37.404084 | PLAY RECAP 2025-09-29 07:29:37.404300 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-29 07:29:37.404367 | 2025-09-29 07:29:37.533813 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-29 07:29:37.535888 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-29 07:29:38.253759 | 2025-09-29 07:29:38.253929 | PLAY [Base post] 2025-09-29 07:29:38.267319 | 2025-09-29 07:29:38.267445 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-29 07:29:39.111358 | debian-bookworm | changed 2025-09-29 07:29:39.119908 | 2025-09-29 07:29:39.120037 | PLAY RECAP 2025-09-29 07:29:39.120111 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-29 07:29:39.120258 | 2025-09-29 07:29:39.239390 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-29 07:29:39.240448 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-29 07:29:40.024563 | 2025-09-29 07:29:40.024798 | PLAY [Base post-logs] 2025-09-29 07:29:40.039032 | 2025-09-29 07:29:40.039213 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-29 07:29:40.491396 | localhost | changed 2025-09-29 07:29:40.501704 | 2025-09-29 07:29:40.501850 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-29 07:29:40.538639 | localhost | ok 2025-09-29 07:29:40.544068 | 2025-09-29 07:29:40.544220 | TASK [Set zuul-log-path fact] 2025-09-29 07:29:40.560457 | localhost | ok 2025-09-29 07:29:40.578345 | 2025-09-29 07:29:40.578488 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-29 07:29:40.615925 | localhost | ok 2025-09-29 07:29:40.619953 | 2025-09-29 07:29:40.620071 | TASK [upload-logs : Create log directories] 2025-09-29 07:29:41.099172 | localhost | changed 2025-09-29 07:29:41.104980 | 2025-09-29 07:29:41.105163 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-29 07:29:41.598584 | localhost -> localhost | ok: Runtime: 0:00:00.006846 2025-09-29 07:29:41.607883 | 2025-09-29 07:29:41.608060 | TASK [upload-logs : Upload logs to log server] 2025-09-29 07:29:42.167870 | localhost | Output suppressed because no_log was given 2025-09-29 07:29:42.172220 | 2025-09-29 07:29:42.172407 | LOOP [upload-logs : Compress console log and json output] 2025-09-29 07:29:42.227754 | localhost | skipping: Conditional result was False 2025-09-29 07:29:42.233297 | localhost | skipping: Conditional result was False 2025-09-29 07:29:42.245494 | 2025-09-29 07:29:42.245729 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-29 07:29:42.291031 | localhost | skipping: Conditional result was False 2025-09-29 07:29:42.291654 | 2025-09-29 07:29:42.295159 | localhost | skipping: Conditional result was False 2025-09-29 07:29:42.308931 | 2025-09-29 07:29:42.309169 | LOOP [upload-logs : Upload console log and json output]