2025-09-10 00:00:09.000602 | Job console starting 2025-09-10 00:00:09.009630 | Updating git repos 2025-09-10 00:00:09.047100 | Cloning repos into workspace 2025-09-10 00:00:09.091634 | Restoring repo states 2025-09-10 00:00:09.110699 | Merging changes 2025-09-10 00:00:09.110715 | Checking out repos 2025-09-10 00:00:09.198032 | Preparing playbooks 2025-09-10 00:00:10.224961 | Running Ansible setup 2025-09-10 00:00:15.539807 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-09-10 00:00:16.682743 | 2025-09-10 00:00:16.682983 | PLAY [Base pre] 2025-09-10 00:00:16.698950 | 2025-09-10 00:00:16.699040 | TASK [Setup log path fact] 2025-09-10 00:00:16.726067 | debian-bookworm | ok 2025-09-10 00:00:16.746637 | 2025-09-10 00:00:16.746748 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 00:00:16.794454 | debian-bookworm | ok 2025-09-10 00:00:16.813627 | 2025-09-10 00:00:16.813741 | TASK [emit-job-header : Print job information] 2025-09-10 00:00:16.885420 | # Job Information 2025-09-10 00:00:16.885580 | Ansible Version: 2.16.14 2025-09-10 00:00:16.885617 | Job: container-image-kolla-ansible-push-2024.2 2025-09-10 00:00:16.885651 | Pipeline: periodic-midnight 2025-09-10 00:00:16.885674 | Executor: 521e9411259a 2025-09-10 00:00:16.885695 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-09-10 00:00:16.885717 | Event ID: 923ce8ab9d094687a884f35250f55a75 2025-09-10 00:00:16.893255 | 2025-09-10 00:00:16.893396 | LOOP [emit-job-header : Print node information] 2025-09-10 00:00:17.249159 | debian-bookworm | ok: 2025-09-10 00:00:17.249422 | debian-bookworm | # Node Information 2025-09-10 00:00:17.249453 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-09-10 00:00:17.249474 | debian-bookworm | Hostname: debian 2025-09-10 00:00:17.249493 | debian-bookworm | Username: zuul 2025-09-10 00:00:17.249510 | debian-bookworm | Distro: Debian 12.12 2025-09-10 00:00:17.249530 | debian-bookworm | Provider: regiocloud-a 2025-09-10 00:00:17.249548 | debian-bookworm | Region: 2025-09-10 00:00:17.249564 | debian-bookworm | Label: debian-bookworm 2025-09-10 00:00:17.249581 | debian-bookworm | Product Name: OpenStack Nova 2025-09-10 00:00:17.249597 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fefa:ef9c 2025-09-10 00:00:17.266455 | 2025-09-10 00:00:17.266555 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-09-10 00:00:18.493110 | debian-bookworm -> localhost | changed 2025-09-10 00:00:18.499404 | 2025-09-10 00:00:18.499491 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-09-10 00:00:20.771221 | debian-bookworm -> localhost | changed 2025-09-10 00:00:20.782235 | 2025-09-10 00:00:20.782325 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-09-10 00:00:21.213472 | debian-bookworm -> localhost | ok 2025-09-10 00:00:21.218268 | 2025-09-10 00:00:21.218354 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-09-10 00:00:21.255385 | debian-bookworm | ok 2025-09-10 00:00:21.274596 | debian-bookworm | included: /var/lib/zuul/builds/58e0292acd4549c1957ae569267c8add/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-09-10 00:00:21.284032 | 2025-09-10 00:00:21.284120 | TASK [add-build-sshkey : Create Temp SSH key] 2025-09-10 00:00:23.515653 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-09-10 00:00:23.515841 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/58e0292acd4549c1957ae569267c8add/work/58e0292acd4549c1957ae569267c8add_id_rsa 2025-09-10 00:00:23.515874 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/58e0292acd4549c1957ae569267c8add/work/58e0292acd4549c1957ae569267c8add_id_rsa.pub 2025-09-10 00:00:23.515896 | debian-bookworm -> localhost | The key fingerprint is: 2025-09-10 00:00:23.515916 | debian-bookworm -> localhost | SHA256:wxZbX0XDsaVFSIflIFRtpXBs/hj8LBBHexHwlwrGYYA zuul-build-sshkey 2025-09-10 00:00:23.515943 | debian-bookworm -> localhost | The key's randomart image is: 2025-09-10 00:00:23.515962 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-09-10 00:00:23.515979 | debian-bookworm -> localhost | | ...++*O%&| 2025-09-10 00:00:23.515997 | debian-bookworm -> localhost | | E o o+B@O| 2025-09-10 00:00:23.516014 | debian-bookworm -> localhost | | . .+ *==+| 2025-09-10 00:00:23.516030 | debian-bookworm -> localhost | | . +..o.=..| 2025-09-10 00:00:23.516046 | debian-bookworm -> localhost | | S .o * | 2025-09-10 00:00:23.516067 | debian-bookworm -> localhost | | . . o +| 2025-09-10 00:00:23.516085 | debian-bookworm -> localhost | | . | 2025-09-10 00:00:23.516101 | debian-bookworm -> localhost | | | 2025-09-10 00:00:23.516117 | debian-bookworm -> localhost | | | 2025-09-10 00:00:23.516133 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-09-10 00:00:23.516188 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.276025 2025-09-10 00:00:23.521936 | 2025-09-10 00:00:23.522015 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-09-10 00:00:23.548532 | debian-bookworm | ok 2025-09-10 00:00:23.562383 | debian-bookworm | included: /var/lib/zuul/builds/58e0292acd4549c1957ae569267c8add/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-09-10 00:00:23.592541 | 2025-09-10 00:00:23.592640 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-09-10 00:00:23.615566 | debian-bookworm | skipping: Conditional result was False 2025-09-10 00:00:23.621345 | 2025-09-10 00:00:23.621597 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-09-10 00:00:24.410204 | debian-bookworm | changed 2025-09-10 00:00:24.414580 | 2025-09-10 00:00:24.414659 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-09-10 00:00:24.679503 | debian-bookworm | ok 2025-09-10 00:00:24.687412 | 2025-09-10 00:00:24.687522 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-09-10 00:00:25.467652 | debian-bookworm | changed 2025-09-10 00:00:25.478339 | 2025-09-10 00:00:25.478442 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-09-10 00:00:26.249418 | debian-bookworm | changed 2025-09-10 00:00:26.264819 | 2025-09-10 00:00:26.264927 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-09-10 00:00:26.307882 | debian-bookworm | skipping: Conditional result was False 2025-09-10 00:00:26.313670 | 2025-09-10 00:00:26.313757 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-09-10 00:00:27.384575 | debian-bookworm -> localhost | changed 2025-09-10 00:00:27.395985 | 2025-09-10 00:00:27.396085 | TASK [add-build-sshkey : Add back temp key] 2025-09-10 00:00:28.151983 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/58e0292acd4549c1957ae569267c8add/work/58e0292acd4549c1957ae569267c8add_id_rsa (zuul-build-sshkey) 2025-09-10 00:00:28.152225 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.023034 2025-09-10 00:00:28.160006 | 2025-09-10 00:00:28.160102 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-09-10 00:00:28.833266 | debian-bookworm | ok 2025-09-10 00:00:28.839218 | 2025-09-10 00:00:28.839307 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-09-10 00:00:28.903128 | debian-bookworm | skipping: Conditional result was False 2025-09-10 00:00:28.913147 | 2025-09-10 00:00:28.913266 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-09-10 00:00:29.548185 | debian-bookworm | ok 2025-09-10 00:00:29.565789 | 2025-09-10 00:00:29.565899 | TASK [validate-host : Define zuul_info_dir fact] 2025-09-10 00:00:29.609481 | debian-bookworm | ok 2025-09-10 00:00:29.615844 | 2025-09-10 00:00:29.615989 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-09-10 00:00:30.273908 | debian-bookworm -> localhost | ok 2025-09-10 00:00:30.279051 | 2025-09-10 00:00:30.279145 | TASK [validate-host : Collect information about the host] 2025-09-10 00:00:31.573104 | debian-bookworm | ok 2025-09-10 00:00:31.585698 | 2025-09-10 00:00:31.585803 | TASK [validate-host : Sanitize hostname] 2025-09-10 00:00:31.855831 | debian-bookworm | ok 2025-09-10 00:00:31.966405 | 2025-09-10 00:00:31.966511 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-09-10 00:00:32.989488 | debian-bookworm -> localhost | changed 2025-09-10 00:00:32.997535 | 2025-09-10 00:00:32.997639 | TASK [validate-host : Collect information about zuul worker] 2025-09-10 00:00:33.441294 | debian-bookworm | ok 2025-09-10 00:00:33.445910 | 2025-09-10 00:00:33.446006 | TASK [validate-host : Write out all zuul information for each host] 2025-09-10 00:00:34.242428 | debian-bookworm -> localhost | changed 2025-09-10 00:00:34.251468 | 2025-09-10 00:00:34.251561 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-09-10 00:00:34.533100 | debian-bookworm | ok 2025-09-10 00:00:34.538503 | 2025-09-10 00:00:34.538593 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-09-10 00:00:35.871240 | debian-bookworm | changed: 2025-09-10 00:00:35.871389 | debian-bookworm | cd+++++++++ src/ 2025-09-10 00:00:35.871417 | debian-bookworm | cd+++++++++ src/github.com/ 2025-09-10 00:00:35.871437 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-09-10 00:00:35.871455 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-09-10 00:00:35.871471 | debian-bookworm | Containerfile 2025-09-10 00:00:35.871578 | debian-bookworm | 2025-09-10 00:09:45.027660 | debian-bookworm | ERROR 2025-09-10 00:09:45.027924 | debian-bookworm | { 2025-09-10 00:09:45.027991 | debian-bookworm | "delta": "0:00:19.254941", 2025-09-10 00:09:45.028036 | debian-bookworm | "end": "2025-09-10 00:09:44.973920", 2025-09-10 00:09:45.028080 | debian-bookworm | "msg": "non-zero return code", 2025-09-10 00:09:45.028116 | debian-bookworm | "rc": 1, 2025-09-10 00:09:45.028150 | debian-bookworm | "start": "2025-09-10 00:09:25.718979" 2025-09-10 00:09:45.028182 | debian-bookworm | } failure 2025-09-10 00:09:45.030448 | 2025-09-10 00:09:45.030538 | PLAY RECAP 2025-09-10 00:09:45.030614 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-09-10 00:09:45.030655 | 2025-09-10 00:09:45.135935 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-09-10 00:09:45.138731 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-10 00:09:45.906818 | 2025-09-10 00:09:45.907017 | PLAY [Base post] 2025-09-10 00:09:45.920979 | 2025-09-10 00:09:45.921112 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-09-10 00:09:46.761585 | debian-bookworm | changed 2025-09-10 00:09:46.771838 | 2025-09-10 00:09:46.771962 | PLAY RECAP 2025-09-10 00:09:46.772039 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-09-10 00:09:46.772117 | 2025-09-10 00:09:46.891096 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-09-10 00:09:46.893632 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-09-10 00:09:47.695201 | 2025-09-10 00:09:47.695409 | PLAY [Base post-logs] 2025-09-10 00:09:47.706935 | 2025-09-10 00:09:47.707083 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-09-10 00:09:48.162193 | localhost | changed 2025-09-10 00:09:48.179211 | 2025-09-10 00:09:48.179418 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-09-10 00:09:48.219263 | localhost | ok 2025-09-10 00:09:48.226738 | 2025-09-10 00:09:48.226915 | TASK [Set zuul-log-path fact] 2025-09-10 00:09:48.244638 | localhost | ok 2025-09-10 00:09:48.256526 | 2025-09-10 00:09:48.256659 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-09-10 00:09:48.283804 | localhost | ok 2025-09-10 00:09:48.291411 | 2025-09-10 00:09:48.291622 | TASK [upload-logs : Create log directories] 2025-09-10 00:09:48.797545 | localhost | changed 2025-09-10 00:09:48.802799 | 2025-09-10 00:09:48.803028 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-09-10 00:09:49.299470 | localhost -> localhost | ok: Runtime: 0:00:00.005064 2025-09-10 00:09:49.308439 | 2025-09-10 00:09:49.308635 | TASK [upload-logs : Upload logs to log server] 2025-09-10 00:09:49.867165 | localhost | Output suppressed because no_log was given 2025-09-10 00:09:49.870690 | 2025-09-10 00:09:49.870951 | LOOP [upload-logs : Compress console log and json output] 2025-09-10 00:09:49.918307 | localhost | skipping: Conditional result was False 2025-09-10 00:09:49.923593 | localhost | skipping: Conditional result was False 2025-09-10 00:09:49.936807 | 2025-09-10 00:09:49.937050 | LOOP [upload-logs : Upload compressed console log and json output] 2025-09-10 00:09:49.983129 | localhost | skipping: Conditional result was False 2025-09-10 00:09:49.983650 | 2025-09-10 00:09:49.987424 | localhost | skipping: Conditional result was False 2025-09-10 00:09:50.002191 | 2025-09-10 00:09:50.002564 | LOOP [upload-logs : Upload console log and json output]