2025-08-28 00:00:09.410728 | Job console starting 2025-08-28 00:00:09.426288 | Updating git repos 2025-08-28 00:00:09.443390 | Cloning repos into workspace 2025-08-28 00:00:09.485084 | Restoring repo states 2025-08-28 00:00:09.501711 | Merging changes 2025-08-28 00:00:09.501727 | Checking out repos 2025-08-28 00:00:09.634175 | Preparing playbooks 2025-08-28 00:00:10.515145 | Running Ansible setup 2025-08-28 00:00:16.626780 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-28 00:00:18.092156 | 2025-08-28 00:00:18.092272 | PLAY [Base pre] 2025-08-28 00:00:18.122215 | 2025-08-28 00:00:18.122341 | TASK [Setup log path fact] 2025-08-28 00:00:18.153209 | debian-bookworm | ok 2025-08-28 00:00:18.169562 | 2025-08-28 00:00:18.169679 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-28 00:00:18.219150 | debian-bookworm | ok 2025-08-28 00:00:18.226883 | 2025-08-28 00:00:18.226986 | TASK [emit-job-header : Print job information] 2025-08-28 00:00:18.347478 | # Job Information 2025-08-28 00:00:18.347619 | Ansible Version: 2.16.14 2025-08-28 00:00:18.347649 | Job: container-image-kolla-ansible-push-2024.1 2025-08-28 00:00:18.347677 | Pipeline: periodic-midnight 2025-08-28 00:00:18.347696 | Executor: 521e9411259a 2025-08-28 00:00:18.347713 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-08-28 00:00:18.347731 | Event ID: 05058649bde94f14a7448f5240e47820 2025-08-28 00:00:18.351826 | 2025-08-28 00:00:18.351902 | LOOP [emit-job-header : Print node information] 2025-08-28 00:00:18.634314 | debian-bookworm | ok: 2025-08-28 00:00:18.634457 | debian-bookworm | # Node Information 2025-08-28 00:00:18.634486 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-28 00:00:18.634507 | debian-bookworm | Hostname: debian 2025-08-28 00:00:18.634525 | debian-bookworm | Username: zuul 2025-08-28 00:00:18.634542 | debian-bookworm | Distro: Debian 12.11 2025-08-28 00:00:18.634563 | debian-bookworm | Provider: regiocloud-a 2025-08-28 00:00:18.634581 | debian-bookworm | Region: 2025-08-28 00:00:18.634598 | debian-bookworm | Label: debian-bookworm 2025-08-28 00:00:18.634614 | debian-bookworm | Product Name: OpenStack Nova 2025-08-28 00:00:18.634629 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe4b:11f 2025-08-28 00:00:18.665181 | 2025-08-28 00:00:18.665918 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-28 00:00:19.921685 | debian-bookworm -> localhost | changed 2025-08-28 00:00:19.927442 | 2025-08-28 00:00:19.927532 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-28 00:00:22.475718 | debian-bookworm -> localhost | changed 2025-08-28 00:00:22.484381 | 2025-08-28 00:00:22.484466 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-28 00:00:23.410642 | debian-bookworm -> localhost | ok 2025-08-28 00:00:23.440145 | 2025-08-28 00:00:23.440256 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-28 00:00:23.481781 | debian-bookworm | ok 2025-08-28 00:00:23.504074 | debian-bookworm | included: /var/lib/zuul/builds/e51fd845d3db40e7bf6d96d28aec22e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-28 00:00:23.508839 | 2025-08-28 00:00:23.508917 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-28 00:00:26.860356 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-28 00:00:26.860527 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/e51fd845d3db40e7bf6d96d28aec22e0/work/e51fd845d3db40e7bf6d96d28aec22e0_id_rsa 2025-08-28 00:00:26.860557 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/e51fd845d3db40e7bf6d96d28aec22e0/work/e51fd845d3db40e7bf6d96d28aec22e0_id_rsa.pub 2025-08-28 00:00:26.860579 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-28 00:00:26.860599 | debian-bookworm -> localhost | SHA256:fIcrut6Di/WzqcuXF5bGBLK9vEJiiFyf4Mzw79uoCJc zuul-build-sshkey 2025-08-28 00:00:26.860627 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-28 00:00:26.860645 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-28 00:00:26.860663 | debian-bookworm -> localhost | | | 2025-08-28 00:00:26.860680 | debian-bookworm -> localhost | | . . | 2025-08-28 00:00:26.860697 | debian-bookworm -> localhost | | + . | 2025-08-28 00:00:26.860713 | debian-bookworm -> localhost | | . o ... .. | 2025-08-28 00:00:26.860730 | debian-bookworm -> localhost | |..B.o ..S+o.. | 2025-08-28 00:00:26.860748 | debian-bookworm -> localhost | |...*oo. o.*o | 2025-08-28 00:00:26.860765 | debian-bookworm -> localhost | |. E..o...=.. | 2025-08-28 00:00:26.860781 | debian-bookworm -> localhost | |... ==+*o. | 2025-08-28 00:00:26.860798 | debian-bookworm -> localhost | | . .+=XO== | 2025-08-28 00:00:26.860815 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-28 00:00:26.860857 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.745878 2025-08-28 00:00:26.866267 | 2025-08-28 00:00:26.866352 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-28 00:00:26.903178 | debian-bookworm | ok 2025-08-28 00:00:26.910561 | debian-bookworm | included: /var/lib/zuul/builds/e51fd845d3db40e7bf6d96d28aec22e0/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-28 00:00:26.946866 | 2025-08-28 00:00:26.946965 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-28 00:00:27.000676 | debian-bookworm | skipping: Conditional result was False 2025-08-28 00:00:27.006097 | 2025-08-28 00:00:27.006189 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-28 00:00:27.783838 | debian-bookworm | changed 2025-08-28 00:00:27.788216 | 2025-08-28 00:00:27.788291 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-28 00:00:28.080344 | debian-bookworm | ok 2025-08-28 00:00:28.084848 | 2025-08-28 00:00:28.084923 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-28 00:00:28.944804 | debian-bookworm | changed 2025-08-28 00:00:28.950705 | 2025-08-28 00:00:28.950784 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-28 00:00:29.704339 | debian-bookworm | changed 2025-08-28 00:00:29.708754 | 2025-08-28 00:00:29.708831 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-28 00:00:29.744413 | debian-bookworm | skipping: Conditional result was False 2025-08-28 00:00:29.749317 | 2025-08-28 00:00:29.749511 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-28 00:00:30.801561 | debian-bookworm -> localhost | changed 2025-08-28 00:00:30.822656 | 2025-08-28 00:00:30.822746 | TASK [add-build-sshkey : Add back temp key] 2025-08-28 00:00:31.496510 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/e51fd845d3db40e7bf6d96d28aec22e0/work/e51fd845d3db40e7bf6d96d28aec22e0_id_rsa (zuul-build-sshkey) 2025-08-28 00:00:31.496698 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.021126 2025-08-28 00:00:31.503930 | 2025-08-28 00:00:31.504036 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-28 00:00:32.347907 | debian-bookworm | ok 2025-08-28 00:00:32.352417 | 2025-08-28 00:00:32.352493 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-28 00:00:32.379392 | debian-bookworm | skipping: Conditional result was False 2025-08-28 00:00:32.388788 | 2025-08-28 00:00:32.388875 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-28 00:00:32.816117 | debian-bookworm | ok 2025-08-28 00:00:32.830140 | 2025-08-28 00:00:32.830232 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-28 00:00:32.884164 | debian-bookworm | ok 2025-08-28 00:00:32.888705 | 2025-08-28 00:00:32.888776 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-28 00:00:33.395777 | debian-bookworm -> localhost | ok 2025-08-28 00:00:33.401212 | 2025-08-28 00:00:33.401289 | TASK [validate-host : Collect information about the host] 2025-08-28 00:00:34.804528 | debian-bookworm | ok 2025-08-28 00:00:34.813654 | 2025-08-28 00:00:34.813739 | TASK [validate-host : Sanitize hostname] 2025-08-28 00:00:35.085398 | debian-bookworm | ok 2025-08-28 00:00:35.167442 | 2025-08-28 00:00:35.167544 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-28 00:00:35.905537 | debian-bookworm -> localhost | changed 2025-08-28 00:00:35.910923 | 2025-08-28 00:00:35.911032 | TASK [validate-host : Collect information about zuul worker] 2025-08-28 00:00:36.554614 | debian-bookworm | ok 2025-08-28 00:00:36.559591 | 2025-08-28 00:00:36.559685 | TASK [validate-host : Write out all zuul information for each host] 2025-08-28 00:00:37.719827 | debian-bookworm -> localhost | changed 2025-08-28 00:00:37.728768 | 2025-08-28 00:00:37.728866 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-28 00:00:38.047881 | debian-bookworm | ok 2025-08-28 00:00:38.053303 | 2025-08-28 00:00:38.053398 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-28 00:00:39.282331 | debian-bookworm | changed: 2025-08-28 00:00:39.282504 | debian-bookworm | cd+++++++++ src/ 2025-08-28 00:00:39.282539 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-28 00:00:39.282564 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-28 00:00:39.282585 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-08-28 00:00:39.282605 | debian-bookworm | Containerfile 2025-08-28 00:00:39.282736 | debian-bookworm | 2025-08-28 00:10:02.076454 | debian-bookworm | ERROR 2025-08-28 00:10:02.076981 | debian-bookworm | { 2025-08-28 00:10:02.077099 | debian-bookworm | "delta": "0:00:23.337804", 2025-08-28 00:10:02.077172 | debian-bookworm | "end": "2025-08-28 00:10:01.630216", 2025-08-28 00:10:02.077248 | debian-bookworm | "msg": "non-zero return code", 2025-08-28 00:10:02.077340 | debian-bookworm | "rc": 1, 2025-08-28 00:10:02.077425 | debian-bookworm | "start": "2025-08-28 00:09:38.292412" 2025-08-28 00:10:02.077481 | debian-bookworm | } failure 2025-08-28 00:10:02.082629 | 2025-08-28 00:10:02.082793 | PLAY RECAP 2025-08-28 00:10:02.082982 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-28 00:10:02.083048 | 2025-08-28 00:10:02.238701 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-08-28 00:10:02.241433 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-28 00:10:03.009319 | 2025-08-28 00:10:03.009497 | PLAY [Base post] 2025-08-28 00:10:03.033593 | 2025-08-28 00:10:03.033793 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-28 00:10:03.866627 | debian-bookworm | changed 2025-08-28 00:10:03.876991 | 2025-08-28 00:10:03.877134 | PLAY RECAP 2025-08-28 00:10:03.877215 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-28 00:10:03.877294 | 2025-08-28 00:10:04.002051 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-28 00:10:04.004853 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-28 00:10:04.812088 | 2025-08-28 00:10:04.812334 | PLAY [Base post-logs] 2025-08-28 00:10:04.823911 | 2025-08-28 00:10:04.824070 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-28 00:10:05.327283 | localhost | changed 2025-08-28 00:10:05.337609 | 2025-08-28 00:10:05.337813 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-28 00:10:05.364212 | localhost | ok 2025-08-28 00:10:05.367491 | 2025-08-28 00:10:05.367593 | TASK [Set zuul-log-path fact] 2025-08-28 00:10:05.383129 | localhost | ok 2025-08-28 00:10:05.392512 | 2025-08-28 00:10:05.392626 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-28 00:10:05.430704 | localhost | ok 2025-08-28 00:10:05.438653 | 2025-08-28 00:10:05.438929 | TASK [upload-logs : Create log directories] 2025-08-28 00:10:05.954682 | localhost | changed 2025-08-28 00:10:05.960782 | 2025-08-28 00:10:05.960990 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-28 00:10:06.455276 | localhost -> localhost | ok: Runtime: 0:00:00.007321 2025-08-28 00:10:06.462166 | 2025-08-28 00:10:06.462330 | TASK [upload-logs : Upload logs to log server] 2025-08-28 00:10:07.018454 | localhost | Output suppressed because no_log was given 2025-08-28 00:10:07.022101 | 2025-08-28 00:10:07.022276 | LOOP [upload-logs : Compress console log and json output] 2025-08-28 00:10:07.078988 | localhost | skipping: Conditional result was False 2025-08-28 00:10:07.086346 | localhost | skipping: Conditional result was False 2025-08-28 00:10:07.102068 | 2025-08-28 00:10:07.102267 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-28 00:10:07.156386 | localhost | skipping: Conditional result was False 2025-08-28 00:10:07.157145 | 2025-08-28 00:10:07.160072 | localhost | skipping: Conditional result was False 2025-08-28 00:10:07.176729 | 2025-08-28 00:10:07.176964 | LOOP [upload-logs : Upload console log and json output]