2025-09-28 00:00:04.257185 | Job console starting 2025-09-28 00:00:04.291720 | Updating git repos 2025-09-28 00:00:04.353232 | Cloning repos into workspace 2025-09-28 00:00:04.414465 | Restoring repo states 2025-09-28 00:00:04.425233 | Merging changes 2025-09-28 00:00:04.425267 | Checking out repos 2025-09-28 00:00:04.571612 | Preparing playbooks 2025-09-28 00:00:05.367338 | Running Ansible setup 2025-09-28 00:00:10.278095 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-28 00:00:13.298897 | 2025-09-28 00:00:13.299321 | PLAY [Base pre] 2025-09-28 00:00:13.339379 | 2025-09-28 00:00:13.339540 | TASK [Setup log path fact] 2025-09-28 00:00:13.378172 | debian-bookworm | ok 2025-09-28 00:00:13.423740 | 2025-09-28 00:00:13.425486 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 00:00:13.513945 | debian-bookworm | ok 2025-09-28 00:00:13.558963 | 2025-09-28 00:00:13.559110 | TASK [emit-job-header : Print job information] 2025-09-28 00:00:13.610436 | # Job Information 2025-09-28 00:00:13.610903 | Ansible Version: 2.16.14 2025-09-28 00:00:13.610950 | Job: container-image-kolla-ansible-push-2024.1 2025-09-28 00:00:13.610987 | Pipeline: periodic-midnight 2025-09-28 00:00:13.611012 | Executor: 521e9411259a 2025-09-28 00:00:13.611033 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-28 00:00:13.611056 | Event ID: ac6448fe7e8e45888fe56ba2ae56bca6 2025-09-28 00:00:13.626926 | 2025-09-28 00:00:13.627083 | LOOP [emit-job-header : Print node information] 2025-09-28 00:00:13.804478 | debian-bookworm | ok: 2025-09-28 00:00:13.804676 | debian-bookworm | # Node Information 2025-09-28 00:00:13.804713 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-28 00:00:13.804740 | debian-bookworm | Hostname: debian 2025-09-28 00:00:13.804762 | debian-bookworm | Username: zuul 2025-09-28 00:00:13.804782 | debian-bookworm | Distro: Debian 12.12 2025-09-28 00:00:13.804806 | debian-bookworm | Provider: regiocloud-a 2025-09-28 00:00:13.804828 | debian-bookworm | Region: 2025-09-28 00:00:13.804849 | debian-bookworm | Label: debian-bookworm 2025-09-28 00:00:13.804868 | debian-bookworm | Product Name: OpenStack Nova 2025-09-28 00:00:13.804889 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe46:2579 2025-09-28 00:00:13.841374 | 2025-09-28 00:00:13.841520 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-28 00:00:15.244590 | debian-bookworm -> localhost | changed 2025-09-28 00:00:15.251746 | 2025-09-28 00:00:15.251845 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-28 00:00:17.506182 | debian-bookworm -> localhost | changed 2025-09-28 00:00:17.517335 | 2025-09-28 00:00:17.517435 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-28 00:00:18.205696 | debian-bookworm -> localhost | ok 2025-09-28 00:00:18.216443 | 2025-09-28 00:00:18.216776 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-28 00:00:18.290146 | debian-bookworm | ok 2025-09-28 00:00:18.352988 | debian-bookworm | included: /var/lib/zuul/builds/8641cfce115544fc97dce5b52bdaba84/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-28 00:00:18.394548 | 2025-09-28 00:00:18.394650 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-28 00:00:22.329034 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-28 00:00:22.329242 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8641cfce115544fc97dce5b52bdaba84/work/8641cfce115544fc97dce5b52bdaba84_id_rsa 2025-09-28 00:00:22.329289 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8641cfce115544fc97dce5b52bdaba84/work/8641cfce115544fc97dce5b52bdaba84_id_rsa.pub 2025-09-28 00:00:22.329312 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-28 00:00:22.329332 | debian-bookworm -> localhost | SHA256:WLBxzpGs8dSVv47N8rdtpAUxvOhRcDgX5g8eZRy3n4U zuul-build-sshkey 2025-09-28 00:00:22.329358 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-28 00:00:22.329377 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-28 00:00:22.329394 | debian-bookworm -> localhost | | o.oo .o=++=| 2025-09-28 00:00:22.329412 | debian-bookworm -> localhost | | .B+.. ++*++| 2025-09-28 00:00:22.329429 | debian-bookworm -> localhost | | .=+ *E=.| 2025-09-28 00:00:22.329445 | debian-bookworm -> localhost | | .o. o.+++| 2025-09-28 00:00:22.329461 | debian-bookworm -> localhost | | . S . ..+o| 2025-09-28 00:00:22.329479 | debian-bookworm -> localhost | | . . o| 2025-09-28 00:00:22.329496 | debian-bookworm -> localhost | | = + | 2025-09-28 00:00:22.329512 | debian-bookworm -> localhost | | o = +| 2025-09-28 00:00:22.329530 | debian-bookworm -> localhost | | o.+o| 2025-09-28 00:00:22.329546 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-28 00:00:22.329586 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.299110 2025-09-28 00:00:22.334707 | 2025-09-28 00:00:22.334786 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-28 00:00:22.371363 | debian-bookworm | ok 2025-09-28 00:00:22.378936 | debian-bookworm | included: /var/lib/zuul/builds/8641cfce115544fc97dce5b52bdaba84/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-28 00:00:22.404826 | 2025-09-28 00:00:22.404928 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-28 00:00:22.428553 | debian-bookworm | skipping: Conditional result was False 2025-09-28 00:00:22.434275 | 2025-09-28 00:00:22.434382 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-28 00:00:23.420343 | debian-bookworm | changed 2025-09-28 00:00:23.424602 | 2025-09-28 00:00:23.424672 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-28 00:00:23.729477 | debian-bookworm | ok 2025-09-28 00:00:23.733988 | 2025-09-28 00:00:23.734072 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-28 00:00:24.547614 | debian-bookworm | changed 2025-09-28 00:00:24.553069 | 2025-09-28 00:00:24.553154 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-28 00:00:25.306966 | debian-bookworm | changed 2025-09-28 00:00:25.311413 | 2025-09-28 00:00:25.311488 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-28 00:00:25.344903 | debian-bookworm | skipping: Conditional result was False 2025-09-28 00:00:25.349801 | 2025-09-28 00:00:25.349879 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-28 00:00:26.765332 | debian-bookworm -> localhost | changed 2025-09-28 00:00:26.773834 | 2025-09-28 00:00:26.773917 | TASK [add-build-sshkey : Add back temp key] 2025-09-28 00:00:27.698278 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8641cfce115544fc97dce5b52bdaba84/work/8641cfce115544fc97dce5b52bdaba84_id_rsa (zuul-build-sshkey) 2025-09-28 00:00:27.698459 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.035581 2025-09-28 00:00:27.704696 | 2025-09-28 00:00:27.704770 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-28 00:00:28.321745 | debian-bookworm | ok 2025-09-28 00:00:28.330779 | 2025-09-28 00:00:28.330881 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-28 00:00:28.368593 | debian-bookworm | skipping: Conditional result was False 2025-09-28 00:00:28.377921 | 2025-09-28 00:00:28.378002 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-28 00:00:28.846368 | debian-bookworm | ok 2025-09-28 00:00:28.861597 | 2025-09-28 00:00:28.861692 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-28 00:00:28.918745 | debian-bookworm | ok 2025-09-28 00:00:28.923017 | 2025-09-28 00:00:28.923092 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-28 00:00:29.709073 | debian-bookworm -> localhost | ok 2025-09-28 00:00:29.714381 | 2025-09-28 00:00:29.714476 | TASK [validate-host : Collect information about the host] 2025-09-28 00:00:30.896498 | debian-bookworm | ok 2025-09-28 00:00:30.906216 | 2025-09-28 00:00:30.906330 | TASK [validate-host : Sanitize hostname] 2025-09-28 00:00:31.055679 | debian-bookworm | ok 2025-09-28 00:00:31.141398 | 2025-09-28 00:00:31.141495 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-28 00:00:32.035854 | debian-bookworm -> localhost | changed 2025-09-28 00:00:32.040649 | 2025-09-28 00:00:32.040733 | TASK [validate-host : Collect information about zuul worker] 2025-09-28 00:00:32.611790 | debian-bookworm | ok 2025-09-28 00:00:32.615625 | 2025-09-28 00:00:32.615700 | TASK [validate-host : Write out all zuul information for each host] 2025-09-28 00:00:33.670336 | debian-bookworm -> localhost | changed 2025-09-28 00:00:33.677970 | 2025-09-28 00:00:33.678047 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-28 00:00:33.975803 | debian-bookworm | ok 2025-09-28 00:00:33.980315 | 2025-09-28 00:00:33.980393 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-28 00:00:35.447682 | debian-bookworm | changed: 2025-09-28 00:00:35.447840 | debian-bookworm | cd+++++++++ src/ 2025-09-28 00:00:35.447870 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-28 00:00:35.447890 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-28 00:00:35.447908 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-28 00:00:35.447925 | debian-bookworm | Containerfile 2025-09-28 00:00:35.448033 | debian-bookworm | 2025-09-28 00:12:03.420118 | debian-bookworm | ERROR 2025-09-28 00:12:03.420600 | debian-bookworm | { 2025-09-28 00:12:03.420718 | debian-bookworm | "delta": "0:00:20.241467", 2025-09-28 00:12:03.420795 | debian-bookworm | "end": "2025-09-28 00:12:02.918233", 2025-09-28 00:12:03.420869 | debian-bookworm | "msg": "non-zero return code", 2025-09-28 00:12:03.420927 | debian-bookworm | "rc": 1, 2025-09-28 00:12:03.420982 | debian-bookworm | "start": "2025-09-28 00:11:42.676766" 2025-09-28 00:12:03.421063 | debian-bookworm | } failure 2025-09-28 00:12:03.425507 | 2025-09-28 00:12:03.425660 | PLAY RECAP 2025-09-28 00:12:03.425783 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-28 00:12:03.425843 | 2025-09-28 00:12:03.561984 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-28 00:12:03.563145 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 00:12:04.298298 | 2025-09-28 00:12:04.298479 | PLAY [Base post] 2025-09-28 00:12:04.312618 | 2025-09-28 00:12:04.312754 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-28 00:12:05.168901 | debian-bookworm | changed 2025-09-28 00:12:05.179189 | 2025-09-28 00:12:05.179316 | PLAY RECAP 2025-09-28 00:12:05.179394 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-28 00:12:05.179474 | 2025-09-28 00:12:05.300142 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-28 00:12:05.301189 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-28 00:12:06.088619 | 2025-09-28 00:12:06.088787 | PLAY [Base post-logs] 2025-09-28 00:12:06.099889 | 2025-09-28 00:12:06.100058 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-28 00:12:06.541093 | localhost | changed 2025-09-28 00:12:06.551081 | 2025-09-28 00:12:06.551218 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-28 00:12:06.587061 | localhost | ok 2025-09-28 00:12:06.590508 | 2025-09-28 00:12:06.590616 | TASK [Set zuul-log-path fact] 2025-09-28 00:12:06.616951 | localhost | ok 2025-09-28 00:12:06.629962 | 2025-09-28 00:12:06.630109 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-28 00:12:06.667845 | localhost | ok 2025-09-28 00:12:06.675132 | 2025-09-28 00:12:06.675302 | TASK [upload-logs : Create log directories] 2025-09-28 00:12:07.184449 | localhost | changed 2025-09-28 00:12:07.188844 | 2025-09-28 00:12:07.188985 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-28 00:12:07.738637 | localhost -> localhost | ok: Runtime: 0:00:00.004578 2025-09-28 00:12:07.743310 | 2025-09-28 00:12:07.743445 | TASK [upload-logs : Upload logs to log server] 2025-09-28 00:12:08.350660 | localhost | Output suppressed because no_log was given 2025-09-28 00:12:08.353216 | 2025-09-28 00:12:08.353338 | LOOP [upload-logs : Compress console log and json output] 2025-09-28 00:12:08.410963 | localhost | skipping: Conditional result was False 2025-09-28 00:12:08.416855 | localhost | skipping: Conditional result was False 2025-09-28 00:12:08.424373 | 2025-09-28 00:12:08.424497 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-28 00:12:08.487360 | localhost | skipping: Conditional result was False 2025-09-28 00:12:08.487655 | 2025-09-28 00:12:08.501402 | localhost | skipping: Conditional result was False 2025-09-28 00:12:08.518231 | 2025-09-28 00:12:08.518486 | LOOP [upload-logs : Upload console log and json output]