2025-09-04 00:00:14.278795 | Job console starting 2025-09-04 00:00:14.292695 | Updating git repos 2025-09-04 00:00:14.590813 | Cloning repos into workspace 2025-09-04 00:00:14.665225 | Restoring repo states 2025-09-04 00:00:14.695552 | Merging changes 2025-09-04 00:00:14.695569 | Checking out repos 2025-09-04 00:00:14.803308 | Preparing playbooks 2025-09-04 00:00:15.597075 | Running Ansible setup 2025-09-04 00:00:21.841752 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-04 00:00:23.937012 | 2025-09-04 00:00:23.937129 | PLAY [Base pre] 2025-09-04 00:00:23.985449 | 2025-09-04 00:00:23.985559 | TASK [Setup log path fact] 2025-09-04 00:00:24.027957 | debian-bookworm | ok 2025-09-04 00:00:24.053348 | 2025-09-04 00:00:24.053495 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-04 00:00:24.136667 | debian-bookworm | ok 2025-09-04 00:00:24.144492 | 2025-09-04 00:00:24.144585 | TASK [emit-job-header : Print job information] 2025-09-04 00:00:24.227354 | # Job Information 2025-09-04 00:00:24.227582 | Ansible Version: 2.16.14 2025-09-04 00:00:24.227614 | Job: container-image-kolla-ansible-push-2024.1 2025-09-04 00:00:24.227647 | Pipeline: periodic-midnight 2025-09-04 00:00:24.227670 | Executor: 521e9411259a 2025-09-04 00:00:24.227687 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-04 00:00:24.227705 | Event ID: 6c7a8b3c39cb402ea7d879ca88789528 2025-09-04 00:00:24.231836 | 2025-09-04 00:00:24.231926 | LOOP [emit-job-header : Print node information] 2025-09-04 00:00:24.423008 | debian-bookworm | ok: 2025-09-04 00:00:24.423182 | debian-bookworm | # Node Information 2025-09-04 00:00:24.423214 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-04 00:00:24.423235 | debian-bookworm | Hostname: debian 2025-09-04 00:00:24.423254 | debian-bookworm | Username: zuul 2025-09-04 00:00:24.423272 | debian-bookworm | Distro: Debian 12.11 2025-09-04 00:00:24.423291 | debian-bookworm | Provider: regiocloud-a 2025-09-04 00:00:24.423309 | debian-bookworm | Region: 2025-09-04 00:00:24.423325 | debian-bookworm | Label: debian-bookworm 2025-09-04 00:00:24.423341 | debian-bookworm | Product Name: OpenStack Nova 2025-09-04 00:00:24.423358 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fec2:e5bf 2025-09-04 00:00:24.441659 | 2025-09-04 00:00:24.441757 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-04 00:00:25.773268 | debian-bookworm -> localhost | changed 2025-09-04 00:00:25.779352 | 2025-09-04 00:00:25.779455 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-04 00:00:27.858567 | debian-bookworm -> localhost | changed 2025-09-04 00:00:27.867297 | 2025-09-04 00:00:27.867382 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-04 00:00:28.879699 | debian-bookworm -> localhost | ok 2025-09-04 00:00:28.884738 | 2025-09-04 00:00:28.884830 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-04 00:00:28.911320 | debian-bookworm | ok 2025-09-04 00:00:28.938926 | debian-bookworm | included: /var/lib/zuul/builds/6c0752798e0e4e6c9a2bf0f470f85d0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-04 00:00:28.957265 | 2025-09-04 00:00:28.957364 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-04 00:00:31.687769 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-04 00:00:31.687943 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/6c0752798e0e4e6c9a2bf0f470f85d0e/work/6c0752798e0e4e6c9a2bf0f470f85d0e_id_rsa 2025-09-04 00:00:31.687975 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/6c0752798e0e4e6c9a2bf0f470f85d0e/work/6c0752798e0e4e6c9a2bf0f470f85d0e_id_rsa.pub 2025-09-04 00:00:31.687997 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-04 00:00:31.688017 | debian-bookworm -> localhost | SHA256:xD/5vquXvQW4MA0+XP2hjU2XcqZ8BQ0lXpvY0sG8DBI zuul-build-sshkey 2025-09-04 00:00:31.688044 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-04 00:00:31.688063 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-04 00:00:31.688080 | debian-bookworm -> localhost | | E. *=o| 2025-09-04 00:00:31.688097 | debian-bookworm -> localhost | | . . ++**| 2025-09-04 00:00:31.688114 | debian-bookworm -> localhost | | o . o+=@+| 2025-09-04 00:00:31.688130 | debian-bookworm -> localhost | | . + =..%++| 2025-09-04 00:00:31.688145 | debian-bookworm -> localhost | | S X o=.+.| 2025-09-04 00:00:31.688165 | debian-bookworm -> localhost | | * ... | 2025-09-04 00:00:31.688182 | debian-bookworm -> localhost | | oo .| 2025-09-04 00:00:31.688198 | debian-bookworm -> localhost | | .o .. | 2025-09-04 00:00:31.688216 | debian-bookworm -> localhost | | .o+o.. | 2025-09-04 00:00:31.688233 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-04 00:00:31.688275 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.730897 2025-09-04 00:00:31.693586 | 2025-09-04 00:00:31.693675 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-04 00:00:31.730403 | debian-bookworm | ok 2025-09-04 00:00:31.749351 | debian-bookworm | included: /var/lib/zuul/builds/6c0752798e0e4e6c9a2bf0f470f85d0e/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-04 00:00:31.779386 | 2025-09-04 00:00:31.779500 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-04 00:00:31.841840 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:31.846995 | 2025-09-04 00:00:31.847088 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-04 00:00:32.693556 | debian-bookworm | changed 2025-09-04 00:00:32.697931 | 2025-09-04 00:00:32.698011 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-04 00:00:32.974986 | debian-bookworm | ok 2025-09-04 00:00:32.984692 | 2025-09-04 00:00:32.984801 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-04 00:00:33.773738 | debian-bookworm | changed 2025-09-04 00:00:33.792938 | 2025-09-04 00:00:33.793054 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-04 00:00:34.576582 | debian-bookworm | changed 2025-09-04 00:00:34.581865 | 2025-09-04 00:00:34.581964 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-04 00:00:34.635402 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:34.642326 | 2025-09-04 00:00:34.642443 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-04 00:00:35.717382 | debian-bookworm -> localhost | changed 2025-09-04 00:00:35.726050 | 2025-09-04 00:00:35.726139 | TASK [add-build-sshkey : Add back temp key] 2025-09-04 00:00:36.363894 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/6c0752798e0e4e6c9a2bf0f470f85d0e/work/6c0752798e0e4e6c9a2bf0f470f85d0e_id_rsa (zuul-build-sshkey) 2025-09-04 00:00:36.364078 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.026490 2025-09-04 00:00:36.370395 | 2025-09-04 00:00:36.370539 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-04 00:00:36.921740 | debian-bookworm | ok 2025-09-04 00:00:36.925970 | 2025-09-04 00:00:36.926054 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-04 00:00:36.968847 | debian-bookworm | skipping: Conditional result was False 2025-09-04 00:00:36.977605 | 2025-09-04 00:00:36.977694 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-04 00:00:37.617948 | debian-bookworm | ok 2025-09-04 00:00:37.636606 | 2025-09-04 00:00:37.636693 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-04 00:00:37.695406 | debian-bookworm | ok 2025-09-04 00:00:37.699398 | 2025-09-04 00:00:37.699481 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-04 00:00:38.681327 | debian-bookworm -> localhost | ok 2025-09-04 00:00:38.686658 | 2025-09-04 00:00:38.686737 | TASK [validate-host : Collect information about the host] 2025-09-04 00:00:39.982064 | debian-bookworm | ok 2025-09-04 00:00:39.999441 | 2025-09-04 00:00:39.999533 | TASK [validate-host : Sanitize hostname] 2025-09-04 00:00:40.255295 | debian-bookworm | ok 2025-09-04 00:00:40.325541 | 2025-09-04 00:00:40.325636 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-04 00:00:41.042919 | debian-bookworm -> localhost | changed 2025-09-04 00:00:41.048825 | 2025-09-04 00:00:41.048907 | TASK [validate-host : Collect information about zuul worker] 2025-09-04 00:00:41.567641 | debian-bookworm | ok 2025-09-04 00:00:41.573482 | 2025-09-04 00:00:41.573570 | TASK [validate-host : Write out all zuul information for each host] 2025-09-04 00:00:42.466067 | debian-bookworm -> localhost | changed 2025-09-04 00:00:42.473789 | 2025-09-04 00:00:42.473868 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-04 00:00:42.764377 | debian-bookworm | ok 2025-09-04 00:00:42.768913 | 2025-09-04 00:00:42.769050 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-04 00:00:43.863766 | debian-bookworm | changed: 2025-09-04 00:00:43.863912 | debian-bookworm | cd+++++++++ src/ 2025-09-04 00:00:43.863939 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-04 00:00:43.863959 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-04 00:00:43.863976 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-04 00:00:43.863993 | debian-bookworm | Containerfile 2025-09-04 00:00:43.864099 | debian-bookworm | 2025-09-04 00:07:22.579424 | debian-bookworm | ERROR 2025-09-04 00:07:22.579921 | debian-bookworm | { 2025-09-04 00:07:22.580089 | debian-bookworm | "delta": "0:00:20.853302", 2025-09-04 00:07:22.580168 | debian-bookworm | "end": "2025-09-04 00:07:22.165313", 2025-09-04 00:07:22.580238 | debian-bookworm | "msg": "non-zero return code", 2025-09-04 00:07:22.580294 | debian-bookworm | "rc": 1, 2025-09-04 00:07:22.580348 | debian-bookworm | "start": "2025-09-04 00:07:01.312011" 2025-09-04 00:07:22.580464 | debian-bookworm | } failure 2025-09-04 00:07:22.584061 | 2025-09-04 00:07:22.584217 | PLAY RECAP 2025-09-04 00:07:22.584337 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-04 00:07:22.584427 | 2025-09-04 00:07:22.742451 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-04 00:07:22.744821 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-04 00:07:23.438036 | 2025-09-04 00:07:23.438156 | PLAY [Base post] 2025-09-04 00:07:23.450109 | 2025-09-04 00:07:23.450209 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-04 00:07:24.258659 | debian-bookworm | changed 2025-09-04 00:07:24.264667 | 2025-09-04 00:07:24.264749 | PLAY RECAP 2025-09-04 00:07:24.264813 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-04 00:07:24.264872 | 2025-09-04 00:07:24.348305 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-04 00:07:24.350717 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-04 00:07:25.099825 | 2025-09-04 00:07:25.099960 | PLAY [Base post-logs] 2025-09-04 00:07:25.109564 | 2025-09-04 00:07:25.109678 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-04 00:07:25.512726 | localhost | changed 2025-09-04 00:07:25.530153 | 2025-09-04 00:07:25.530308 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-04 00:07:25.567636 | localhost | ok 2025-09-04 00:07:25.572977 | 2025-09-04 00:07:25.573107 | TASK [Set zuul-log-path fact] 2025-09-04 00:07:25.590094 | localhost | ok 2025-09-04 00:07:25.603364 | 2025-09-04 00:07:25.603522 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-04 00:07:25.631956 | localhost | ok 2025-09-04 00:07:25.640747 | 2025-09-04 00:07:25.640887 | TASK [upload-logs : Create log directories] 2025-09-04 00:07:26.086819 | localhost | changed 2025-09-04 00:07:26.089536 | 2025-09-04 00:07:26.089632 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-04 00:07:26.532006 | localhost -> localhost | ok: Runtime: 0:00:00.006750 2025-09-04 00:07:26.538665 | 2025-09-04 00:07:26.538771 | TASK [upload-logs : Upload logs to log server] 2025-09-04 00:07:27.079369 | localhost | Output suppressed because no_log was given 2025-09-04 00:07:27.080968 | 2025-09-04 00:07:27.081072 | LOOP [upload-logs : Compress console log and json output] 2025-09-04 00:07:27.121206 | localhost | skipping: Conditional result was False 2025-09-04 00:07:27.126594 | localhost | skipping: Conditional result was False 2025-09-04 00:07:27.141353 | 2025-09-04 00:07:27.141549 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-04 00:07:27.185006 | localhost | skipping: Conditional result was False 2025-09-04 00:07:27.185538 | 2025-09-04 00:07:27.189087 | localhost | skipping: Conditional result was False 2025-09-04 00:07:27.202458 | 2025-09-04 00:07:27.202672 | LOOP [upload-logs : Upload console log and json output]