2025-09-23 11:59:19.299531 | Job console starting 2025-09-23 11:59:19.320571 | Updating git repos 2025-09-23 11:59:19.366233 | Cloning repos into workspace 2025-09-23 11:59:19.417940 | Restoring repo states 2025-09-23 11:59:19.436424 | Merging changes 2025-09-23 11:59:19.436443 | Checking out repos 2025-09-23 11:59:19.503978 | Preparing playbooks 2025-09-23 11:59:20.164378 | Running Ansible setup 2025-09-23 11:59:24.373726 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-23 11:59:25.164939 | 2025-09-23 11:59:25.165113 | PLAY [Base pre] 2025-09-23 11:59:25.181977 | 2025-09-23 11:59:25.182115 | TASK [Setup log path fact] 2025-09-23 11:59:25.211330 | debian-bookworm | ok 2025-09-23 11:59:25.226374 | 2025-09-23 11:59:25.226511 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 11:59:25.268421 | debian-bookworm | ok 2025-09-23 11:59:25.278704 | 2025-09-23 11:59:25.278812 | TASK [emit-job-header : Print job information] 2025-09-23 11:59:25.332823 | # Job Information 2025-09-23 11:59:25.333108 | Ansible Version: 2.16.14 2025-09-23 11:59:25.333168 | Job: container-image-kolla-ansible-push-2024.1 2025-09-23 11:59:25.333229 | Pipeline: post 2025-09-23 11:59:25.333271 | Executor: 521e9411259a 2025-09-23 11:59:25.333307 | Triggered by: https://github.com/osism/container-image-kolla-ansible/commit/d296a663b80a94200ff988180211b03788377ff1 2025-09-23 11:59:25.333347 | Event ID: b9cb4bb2-9874-11f0-9e6e-9031dbda713c 2025-09-23 11:59:25.340674 | 2025-09-23 11:59:25.340807 | LOOP [emit-job-header : Print node information] 2025-09-23 11:59:25.463980 | debian-bookworm | ok: 2025-09-23 11:59:25.464288 | debian-bookworm | # Node Information 2025-09-23 11:59:25.464349 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-23 11:59:25.464395 | debian-bookworm | Hostname: debian 2025-09-23 11:59:25.464436 | debian-bookworm | Username: zuul 2025-09-23 11:59:25.464473 | debian-bookworm | Distro: Debian 12.12 2025-09-23 11:59:25.464515 | debian-bookworm | Provider: regiocloud-a 2025-09-23 11:59:25.464553 | debian-bookworm | Region: 2025-09-23 11:59:25.464591 | debian-bookworm | Label: debian-bookworm 2025-09-23 11:59:25.464628 | debian-bookworm | Product Name: OpenStack Nova 2025-09-23 11:59:25.464663 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe42:2e18 2025-09-23 11:59:25.489461 | 2025-09-23 11:59:25.489615 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-23 11:59:25.935702 | debian-bookworm -> localhost | changed 2025-09-23 11:59:25.950935 | 2025-09-23 11:59:25.951080 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-23 11:59:26.979246 | debian-bookworm -> localhost | changed 2025-09-23 11:59:26.991101 | 2025-09-23 11:59:26.991242 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-23 11:59:27.291018 | debian-bookworm -> localhost | ok 2025-09-23 11:59:27.297969 | 2025-09-23 11:59:27.298096 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-23 11:59:27.346545 | debian-bookworm | ok 2025-09-23 11:59:27.370828 | debian-bookworm | included: /var/lib/zuul/builds/fd779ebd4f00407fa8110634906ee8f9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-23 11:59:27.377073 | 2025-09-23 11:59:27.377173 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-23 11:59:28.350154 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-23 11:59:28.350423 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fd779ebd4f00407fa8110634906ee8f9/work/fd779ebd4f00407fa8110634906ee8f9_id_rsa 2025-09-23 11:59:28.350464 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fd779ebd4f00407fa8110634906ee8f9/work/fd779ebd4f00407fa8110634906ee8f9_id_rsa.pub 2025-09-23 11:59:28.350493 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-23 11:59:28.350518 | debian-bookworm -> localhost | SHA256:GD7XWRQfpSTYSary8ebxNEzBdv+BRkaypMJxPFwZGpI zuul-build-sshkey 2025-09-23 11:59:28.350552 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-23 11:59:28.350576 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-23 11:59:28.350597 | debian-bookworm -> localhost | | o+o.OB+o..| 2025-09-23 11:59:28.350619 | debian-bookworm -> localhost | | .E++*=*+ o | 2025-09-23 11:59:28.350640 | debian-bookworm -> localhost | | .o oo.=o+ | 2025-09-23 11:59:28.350660 | debian-bookworm -> localhost | | . o.o +oo.. | 2025-09-23 11:59:28.350680 | debian-bookworm -> localhost | | = S o .o ..| 2025-09-23 11:59:28.350707 | debian-bookworm -> localhost | | = o o. o| 2025-09-23 11:59:28.350728 | debian-bookworm -> localhost | | . + + .| 2025-09-23 11:59:28.350749 | debian-bookworm -> localhost | | o + . | 2025-09-23 11:59:28.350770 | debian-bookworm -> localhost | | . . | 2025-09-23 11:59:28.350791 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-23 11:59:28.350991 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.469136 2025-09-23 11:59:28.362107 | 2025-09-23 11:59:28.362303 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-23 11:59:28.390344 | debian-bookworm | ok 2025-09-23 11:59:28.400132 | debian-bookworm | included: /var/lib/zuul/builds/fd779ebd4f00407fa8110634906ee8f9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-23 11:59:28.409154 | 2025-09-23 11:59:28.409249 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-23 11:59:28.432322 | debian-bookworm | skipping: Conditional result was False 2025-09-23 11:59:28.438080 | 2025-09-23 11:59:28.438182 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-23 11:59:29.097419 | debian-bookworm | changed 2025-09-23 11:59:29.105753 | 2025-09-23 11:59:29.105934 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-23 11:59:29.368349 | debian-bookworm | ok 2025-09-23 11:59:29.374250 | 2025-09-23 11:59:29.374359 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-23 11:59:30.048638 | debian-bookworm | changed 2025-09-23 11:59:30.058641 | 2025-09-23 11:59:30.058771 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-23 11:59:30.744384 | debian-bookworm | changed 2025-09-23 11:59:30.753881 | 2025-09-23 11:59:30.754061 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-23 11:59:30.778608 | debian-bookworm | skipping: Conditional result was False 2025-09-23 11:59:30.784753 | 2025-09-23 11:59:30.784857 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-23 11:59:31.275451 | debian-bookworm -> localhost | changed 2025-09-23 11:59:31.286979 | 2025-09-23 11:59:31.287090 | TASK [add-build-sshkey : Add back temp key] 2025-09-23 11:59:31.646937 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fd779ebd4f00407fa8110634906ee8f9/work/fd779ebd4f00407fa8110634906ee8f9_id_rsa (zuul-build-sshkey) 2025-09-23 11:59:31.647454 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.019222 2025-09-23 11:59:31.663204 | 2025-09-23 11:59:31.663338 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-23 11:59:32.048605 | debian-bookworm | ok 2025-09-23 11:59:32.054121 | 2025-09-23 11:59:32.054226 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-23 11:59:32.079775 | debian-bookworm | skipping: Conditional result was False 2025-09-23 11:59:32.098171 | 2025-09-23 11:59:32.098310 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-23 11:59:32.550746 | debian-bookworm | ok 2025-09-23 11:59:32.567100 | 2025-09-23 11:59:32.567293 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-23 11:59:32.614431 | debian-bookworm | ok 2025-09-23 11:59:32.622732 | 2025-09-23 11:59:32.622925 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-23 11:59:32.931063 | debian-bookworm -> localhost | ok 2025-09-23 11:59:32.942250 | 2025-09-23 11:59:32.942393 | TASK [validate-host : Collect information about the host] 2025-09-23 11:59:34.070351 | debian-bookworm | ok 2025-09-23 11:59:34.085515 | 2025-09-23 11:59:34.085637 | TASK [validate-host : Sanitize hostname] 2025-09-23 11:59:34.200344 | debian-bookworm | ok 2025-09-23 11:59:34.250350 | 2025-09-23 11:59:34.250613 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-23 11:59:34.795836 | debian-bookworm -> localhost | changed 2025-09-23 11:59:34.802036 | 2025-09-23 11:59:34.802165 | TASK [validate-host : Collect information about zuul worker] 2025-09-23 11:59:35.260442 | debian-bookworm | ok 2025-09-23 11:59:35.268590 | 2025-09-23 11:59:35.268730 | TASK [validate-host : Write out all zuul information for each host] 2025-09-23 11:59:35.805983 | debian-bookworm -> localhost | changed 2025-09-23 11:59:35.823232 | 2025-09-23 11:59:35.823368 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-23 11:59:36.105024 | debian-bookworm | ok 2025-09-23 11:59:36.114280 | 2025-09-23 11:59:36.114418 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-23 11:59:36.954874 | debian-bookworm | changed: 2025-09-23 11:59:36.955133 | debian-bookworm | cd+++++++++ src/ 2025-09-23 11:59:36.955169 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-23 11:59:36.955194 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-23 11:59:36.955216 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-23 11:59:36.955237 | debian-bookworm | Containerfile 2025-09-23 11:59:36.955369 | debian-bookworm | 2025-09-23 12:09:20.210233 | debian-bookworm | ERROR 2025-09-23 12:09:20.210547 | debian-bookworm | { 2025-09-23 12:09:20.210630 | debian-bookworm | "delta": "0:00:21.225516", 2025-09-23 12:09:20.210676 | debian-bookworm | "end": "2025-09-23 12:09:20.149611", 2025-09-23 12:09:20.210722 | debian-bookworm | "msg": "non-zero return code", 2025-09-23 12:09:20.210754 | debian-bookworm | "rc": 1, 2025-09-23 12:09:20.210784 | debian-bookworm | "start": "2025-09-23 12:08:58.924095" 2025-09-23 12:09:20.210818 | debian-bookworm | } failure 2025-09-23 12:09:20.212916 | 2025-09-23 12:09:20.213045 | PLAY RECAP 2025-09-23 12:09:20.213109 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-23 12:09:20.213137 | 2025-09-23 12:09:20.408057 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-23 12:09:20.411116 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-23 12:09:21.163457 | 2025-09-23 12:09:21.163616 | PLAY [Base post] 2025-09-23 12:09:21.177859 | 2025-09-23 12:09:21.178041 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-23 12:09:22.008699 | debian-bookworm | changed 2025-09-23 12:09:22.015383 | 2025-09-23 12:09:22.015501 | PLAY RECAP 2025-09-23 12:09:22.015566 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-23 12:09:22.015629 | 2025-09-23 12:09:22.131188 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-23 12:09:22.132302 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-23 12:09:22.947219 | 2025-09-23 12:09:22.947483 | PLAY [Base post-logs] 2025-09-23 12:09:22.959086 | 2025-09-23 12:09:22.959235 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-23 12:09:23.431448 | localhost | changed 2025-09-23 12:09:23.441737 | 2025-09-23 12:09:23.441884 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-23 12:09:23.479077 | localhost | ok 2025-09-23 12:09:23.482436 | 2025-09-23 12:09:23.482536 | TASK [Set zuul-log-path fact] 2025-09-23 12:09:23.498696 | localhost | ok 2025-09-23 12:09:23.507231 | 2025-09-23 12:09:23.507346 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-23 12:09:23.533564 | localhost | ok 2025-09-23 12:09:23.536852 | 2025-09-23 12:09:23.536998 | TASK [upload-logs : Create log directories] 2025-09-23 12:09:24.061849 | localhost | changed 2025-09-23 12:09:24.064746 | 2025-09-23 12:09:24.064860 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-23 12:09:24.542777 | localhost -> localhost | ok: Runtime: 0:00:00.007659 2025-09-23 12:09:24.548063 | 2025-09-23 12:09:24.548176 | TASK [upload-logs : Upload logs to log server] 2025-09-23 12:09:25.129873 | localhost | Output suppressed because no_log was given 2025-09-23 12:09:25.133917 | 2025-09-23 12:09:25.134164 | LOOP [upload-logs : Compress console log and json output] 2025-09-23 12:09:25.189191 | localhost | skipping: Conditional result was False 2025-09-23 12:09:25.196465 | localhost | skipping: Conditional result was False 2025-09-23 12:09:25.203789 | 2025-09-23 12:09:25.203902 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-23 12:09:25.249537 | localhost | skipping: Conditional result was False 2025-09-23 12:09:25.249818 | 2025-09-23 12:09:25.256283 | localhost | skipping: Conditional result was False 2025-09-23 12:09:25.263192 | 2025-09-23 12:09:25.263387 | LOOP [upload-logs : Upload console log and json output]