2025-08-15 00:00:06.183076 | Job console starting 2025-08-15 00:00:06.214066 | Updating git repos 2025-08-15 00:00:06.253605 | Cloning repos into workspace 2025-08-15 00:00:06.295133 | Restoring repo states 2025-08-15 00:00:06.309881 | Merging changes 2025-08-15 00:00:06.309895 | Checking out repos 2025-08-15 00:00:06.409233 | Preparing playbooks 2025-08-15 00:00:07.001663 | Running Ansible setup 2025-08-15 00:00:11.482040 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-08-15 00:00:12.953535 | 2025-08-15 00:00:12.953660 | PLAY [Base pre] 2025-08-15 00:00:12.975868 | 2025-08-15 00:00:12.976059 | TASK [Setup log path fact] 2025-08-15 00:00:12.995774 | debian-bookworm | ok 2025-08-15 00:00:13.036158 | 2025-08-15 00:00:13.039980 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-15 00:00:13.116423 | debian-bookworm | ok 2025-08-15 00:00:13.140377 | 2025-08-15 00:00:13.140495 | TASK [emit-job-header : Print job information] 2025-08-15 00:00:13.210683 | # Job Information 2025-08-15 00:00:13.210880 | Ansible Version: 2.16.14 2025-08-15 00:00:13.210920 | Job: container-image-kolla-ansible-push-2024.1 2025-08-15 00:00:13.210955 | Pipeline: periodic-midnight 2025-08-15 00:00:13.210979 | Executor: 521e9411259a 2025-08-15 00:00:13.211000 | Triggered by: https://github.com/osism/container-image-kolla-ansible 2025-08-15 00:00:13.211024 | Event ID: 89d1f9dec749421dbdc3d35854f10e8a 2025-08-15 00:00:13.218939 | 2025-08-15 00:00:13.219061 | LOOP [emit-job-header : Print node information] 2025-08-15 00:00:13.391255 | debian-bookworm | ok: 2025-08-15 00:00:13.391651 | debian-bookworm | # Node Information 2025-08-15 00:00:13.392101 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-08-15 00:00:13.392146 | debian-bookworm | Hostname: debian 2025-08-15 00:00:13.392175 | debian-bookworm | Username: zuul 2025-08-15 00:00:13.392202 | debian-bookworm | Distro: Debian 12.11 2025-08-15 00:00:13.392229 | debian-bookworm | Provider: regiocloud-a 2025-08-15 00:00:13.392262 | debian-bookworm | Region: 2025-08-15 00:00:13.392349 | debian-bookworm | Label: debian-bookworm 2025-08-15 00:00:13.392979 | debian-bookworm | Product Name: OpenStack Nova 2025-08-15 00:00:13.393096 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe06:7d62 2025-08-15 00:00:13.408836 | 2025-08-15 00:00:13.408931 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-08-15 00:00:14.402738 | debian-bookworm -> localhost | changed 2025-08-15 00:00:14.416663 | 2025-08-15 00:00:14.416772 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-08-15 00:00:16.613119 | debian-bookworm -> localhost | changed 2025-08-15 00:00:16.621716 | 2025-08-15 00:00:16.621827 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-08-15 00:00:17.196029 | debian-bookworm -> localhost | ok 2025-08-15 00:00:17.201492 | 2025-08-15 00:00:17.201640 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-08-15 00:00:17.239882 | debian-bookworm | ok 2025-08-15 00:00:17.305251 | debian-bookworm | included: /var/lib/zuul/builds/c872fc57b33349208936d870b9c37f1b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-08-15 00:00:17.341078 | 2025-08-15 00:00:17.341185 | TASK [add-build-sshkey : Create Temp SSH key] 2025-08-15 00:00:20.928992 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-08-15 00:00:20.929163 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c872fc57b33349208936d870b9c37f1b/work/c872fc57b33349208936d870b9c37f1b_id_rsa 2025-08-15 00:00:20.929195 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c872fc57b33349208936d870b9c37f1b/work/c872fc57b33349208936d870b9c37f1b_id_rsa.pub 2025-08-15 00:00:20.929216 | debian-bookworm -> localhost | The key fingerprint is: 2025-08-15 00:00:20.929235 | debian-bookworm -> localhost | SHA256:dwOjknhIXCUVbbB7KnHQTovVXwF7DqrXzF5O+fblTJc zuul-build-sshkey 2025-08-15 00:00:20.929260 | debian-bookworm -> localhost | The key's randomart image is: 2025-08-15 00:00:20.929279 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-08-15 00:00:20.929296 | debian-bookworm -> localhost | | oo=+ ... | 2025-08-15 00:00:20.929313 | debian-bookworm -> localhost | | . . o oo . . | 2025-08-15 00:00:20.929330 | debian-bookworm -> localhost | | o . =.+ o o | 2025-08-15 00:00:20.929346 | debian-bookworm -> localhost | | . o B + = = | 2025-08-15 00:00:20.929362 | debian-bookworm -> localhost | | o * S + + . | 2025-08-15 00:00:20.929381 | debian-bookworm -> localhost | | . + = = . ..| 2025-08-15 00:00:20.929398 | debian-bookworm -> localhost | | . o . + +E+| 2025-08-15 00:00:20.929413 | debian-bookworm -> localhost | | . . . + =+| 2025-08-15 00:00:20.929430 | debian-bookworm -> localhost | | . ..*| 2025-08-15 00:00:20.929447 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-08-15 00:00:20.929490 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.070729 2025-08-15 00:00:20.934598 | 2025-08-15 00:00:20.934669 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-08-15 00:00:20.960938 | debian-bookworm | ok 2025-08-15 00:00:20.968375 | debian-bookworm | included: /var/lib/zuul/builds/c872fc57b33349208936d870b9c37f1b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-08-15 00:00:20.987827 | 2025-08-15 00:00:20.987913 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-08-15 00:00:21.027261 | debian-bookworm | skipping: Conditional result was False 2025-08-15 00:00:21.032146 | 2025-08-15 00:00:21.032235 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-08-15 00:00:22.023901 | debian-bookworm | changed 2025-08-15 00:00:22.031582 | 2025-08-15 00:00:22.031678 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-08-15 00:00:22.344702 | debian-bookworm | ok 2025-08-15 00:00:22.349088 | 2025-08-15 00:00:22.349162 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-08-15 00:00:23.093184 | debian-bookworm | changed 2025-08-15 00:00:23.098566 | 2025-08-15 00:00:23.098649 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-08-15 00:00:23.911177 | debian-bookworm | changed 2025-08-15 00:00:23.915511 | 2025-08-15 00:00:23.915583 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-08-15 00:00:23.947839 | debian-bookworm | skipping: Conditional result was False 2025-08-15 00:00:23.953836 | 2025-08-15 00:00:23.953935 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-08-15 00:00:25.011330 | debian-bookworm -> localhost | changed 2025-08-15 00:00:25.020749 | 2025-08-15 00:00:25.020855 | TASK [add-build-sshkey : Add back temp key] 2025-08-15 00:00:25.920720 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c872fc57b33349208936d870b9c37f1b/work/c872fc57b33349208936d870b9c37f1b_id_rsa (zuul-build-sshkey) 2025-08-15 00:00:25.920936 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.027033 2025-08-15 00:00:25.927209 | 2025-08-15 00:00:25.927290 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-08-15 00:00:26.633717 | debian-bookworm | ok 2025-08-15 00:00:26.637724 | 2025-08-15 00:00:26.637822 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-08-15 00:00:26.711557 | debian-bookworm | skipping: Conditional result was False 2025-08-15 00:00:26.720027 | 2025-08-15 00:00:26.720112 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-08-15 00:00:27.394709 | debian-bookworm | ok 2025-08-15 00:00:27.415220 | 2025-08-15 00:00:27.415322 | TASK [validate-host : Define zuul_info_dir fact] 2025-08-15 00:00:27.474803 | debian-bookworm | ok 2025-08-15 00:00:27.479549 | 2025-08-15 00:00:27.479632 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-08-15 00:00:27.873180 | debian-bookworm -> localhost | ok 2025-08-15 00:00:27.878295 | 2025-08-15 00:00:27.878382 | TASK [validate-host : Collect information about the host] 2025-08-15 00:00:29.313666 | debian-bookworm | ok 2025-08-15 00:00:29.326427 | 2025-08-15 00:00:29.326523 | TASK [validate-host : Sanitize hostname] 2025-08-15 00:00:29.489899 | debian-bookworm | ok 2025-08-15 00:00:29.575324 | 2025-08-15 00:00:29.575424 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-08-15 00:00:30.550439 | debian-bookworm -> localhost | changed 2025-08-15 00:00:30.561765 | 2025-08-15 00:00:30.561879 | TASK [validate-host : Collect information about zuul worker] 2025-08-15 00:00:31.114499 | debian-bookworm | ok 2025-08-15 00:00:31.118319 | 2025-08-15 00:00:31.118399 | TASK [validate-host : Write out all zuul information for each host] 2025-08-15 00:00:32.547365 | debian-bookworm -> localhost | changed 2025-08-15 00:00:32.555086 | 2025-08-15 00:00:32.555166 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-08-15 00:00:32.813207 | debian-bookworm | ok 2025-08-15 00:00:32.818109 | 2025-08-15 00:00:32.818193 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-08-15 00:00:34.200331 | debian-bookworm | changed: 2025-08-15 00:00:34.200484 | debian-bookworm | cd+++++++++ src/ 2025-08-15 00:00:34.200513 | debian-bookworm | cd+++++++++ src/github.com/ 2025-08-15 00:00:34.200534 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-08-15 00:00:34.200552 | debian-bookworm | cd+++++++++ src/github.com/osism/container-image-kolla-ansible/ 2025-08-15 00:00:34.200569 | debian-bookworm | Containerfile 2025-08-15 00:00:34.200677 | debian-bookworm | 2025-08-15 00:11:16.256604 | debian-bookworm | ERROR 2025-08-15 00:11:16.256904 | debian-bookworm | { 2025-08-15 00:11:16.257006 | debian-bookworm | "delta": "0:00:20.266238", 2025-08-15 00:11:16.257072 | debian-bookworm | "end": "2025-08-15 00:11:15.757806", 2025-08-15 00:11:16.257135 | debian-bookworm | "msg": "non-zero return code", 2025-08-15 00:11:16.257187 | debian-bookworm | "rc": 1, 2025-08-15 00:11:16.257236 | debian-bookworm | "start": "2025-08-15 00:10:55.491568" 2025-08-15 00:11:16.257283 | debian-bookworm | } failure 2025-08-15 00:11:16.260837 | 2025-08-15 00:11:16.260983 | PLAY RECAP 2025-08-15 00:11:16.261082 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2025-08-15 00:11:16.261131 | 2025-08-15 00:11:16.433804 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/container-image-kolla-ansible/playbooks/build.yml@main] 2025-08-15 00:11:16.435204 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-15 00:11:17.251879 | 2025-08-15 00:11:17.252045 | PLAY [Base post] 2025-08-15 00:11:17.266233 | 2025-08-15 00:11:17.266367 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-08-15 00:11:18.124377 | debian-bookworm | changed 2025-08-15 00:11:18.134743 | 2025-08-15 00:11:18.134905 | PLAY RECAP 2025-08-15 00:11:18.134987 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-08-15 00:11:18.135069 | 2025-08-15 00:11:18.254462 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-08-15 00:11:18.256565 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-08-15 00:11:19.058444 | 2025-08-15 00:11:19.058615 | PLAY [Base post-logs] 2025-08-15 00:11:19.069853 | 2025-08-15 00:11:19.069988 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-08-15 00:11:19.524927 | localhost | changed 2025-08-15 00:11:19.543160 | 2025-08-15 00:11:19.543336 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-08-15 00:11:19.570254 | localhost | ok 2025-08-15 00:11:19.574699 | 2025-08-15 00:11:19.574873 | TASK [Set zuul-log-path fact] 2025-08-15 00:11:19.601859 | localhost | ok 2025-08-15 00:11:19.613508 | 2025-08-15 00:11:19.613651 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-08-15 00:11:19.644971 | localhost | ok 2025-08-15 00:11:19.652137 | 2025-08-15 00:11:19.652294 | TASK [upload-logs : Create log directories] 2025-08-15 00:11:20.169477 | localhost | changed 2025-08-15 00:11:20.175328 | 2025-08-15 00:11:20.175492 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-08-15 00:11:20.678424 | localhost -> localhost | ok: Runtime: 0:00:00.006789 2025-08-15 00:11:20.684450 | 2025-08-15 00:11:20.684595 | TASK [upload-logs : Upload logs to log server] 2025-08-15 00:11:21.269576 | localhost | Output suppressed because no_log was given 2025-08-15 00:11:21.271729 | 2025-08-15 00:11:21.271843 | LOOP [upload-logs : Compress console log and json output] 2025-08-15 00:11:21.327478 | localhost | skipping: Conditional result was False 2025-08-15 00:11:21.332125 | localhost | skipping: Conditional result was False 2025-08-15 00:11:21.344927 | 2025-08-15 00:11:21.345136 | LOOP [upload-logs : Upload compressed console log and json output] 2025-08-15 00:11:21.391177 | localhost | skipping: Conditional result was False 2025-08-15 00:11:21.391854 | 2025-08-15 00:11:21.395103 | localhost | skipping: Conditional result was False 2025-08-15 00:11:21.409293 | 2025-08-15 00:11:21.409520 | LOOP [upload-logs : Upload console log and json output]